builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1462452994.35 results: success (0) buildid: 20160505030327 builduid: ca051577918442339c331ae12a805704 revision: 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.350968) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.351394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.351845) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.428693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.428980) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 05:56:34-- 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% 13.9M=0.001s 2016-05-05 05:56:34 (13.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160347 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.628971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.629280) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.087458 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.728258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.728617) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b --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=4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 05:56:34,419 truncating revision to first 12 chars 2016-05-05 05:56:34,419 Setting DEBUG logging. 2016-05-05 05:56:34,419 attempt 1/10 2016-05-05 05:56:34,419 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/369a5ee3a288?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 05:56:34,737 unpacking tar archive at: mozilla-central-369a5ee3a288/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644666 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:35.384812) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:35.385113) ========= script_repo_revision: 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:35.388523) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:35.388824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:35.400654) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-05 05:56:35.401019) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:56:35 INFO - MultiFileLogger online at 20160505 05:56:35 in /builds/slave/test 05:56:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:56:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:35 INFO - {'append_to_log': False, 05:56:35 INFO - 'base_work_dir': '/builds/slave/test', 05:56:35 INFO - 'blob_upload_branch': 'Firefox', 05:56:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:35 INFO - 'branch': 'Firefox', 05:56:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:35 INFO - 'config_files': ('talos/linux_config.py',), 05:56:35 INFO - 'default_actions': ('clobber', 05:56:35 INFO - 'read-buildbot-config', 05:56:35 INFO - 'download-and-extract', 05:56:35 INFO - 'populate-webroot', 05:56:35 INFO - 'create-virtualenv', 05:56:35 INFO - 'install', 05:56:35 INFO - 'run-tests'), 05:56:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:35 INFO - 'download_minidump_stackwalk': True, 05:56:35 INFO - 'download_symbols': 'ondemand', 05:56:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:56:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:56:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:56:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:56:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:35 INFO - 'installer_path': 'installer.exe', 05:56:35 INFO - 'log_level': 'info', 05:56:35 INFO - 'log_name': 'talos', 05:56:35 INFO - 'log_to_console': True, 05:56:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:56:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:56:35 INFO - 'opt_config_files': (), 05:56:35 INFO - 'pip_index': False, 05:56:35 INFO - 'sps_profile': False, 05:56:35 INFO - 'sps_profile_interval': 0, 05:56:35 INFO - 'suite': 'dromaeojs', 05:56:35 INFO - 'system_bits': '32', 05:56:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:35 INFO - 'title': 'talos-linux64-ix-030', 05:56:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:35 INFO - 'use_talos_json': True, 05:56:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:35 INFO - 'work_dir': 'build'} 05:56:35 INFO - ##### 05:56:35 INFO - ##### Running clobber step. 05:56:35 INFO - ##### 05:56:35 INFO - Running pre-action listener: _resource_record_pre_action 05:56:35 INFO - Running main action method: clobber 05:56:35 INFO - rmtree: /builds/slave/test/build 05:56:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:37 INFO - Running post-action listener: _resource_record_post_action 05:56:37 INFO - ##### 05:56:37 INFO - ##### Running read-buildbot-config step. 05:56:37 INFO - ##### 05:56:37 INFO - Running pre-action listener: _resource_record_pre_action 05:56:37 INFO - Running main action method: read_buildbot_config 05:56:37 INFO - Using buildbot properties: 05:56:37 INFO - { 05:56:37 INFO - "project": "", 05:56:37 INFO - "product": "firefox", 05:56:37 INFO - "script_repo_revision": "production", 05:56:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:56:37 INFO - "repository": "", 05:56:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:56:37 INFO - "buildid": "20160505030327", 05:56:37 INFO - "stage_platform": "linux64-pgo", 05:56:37 INFO - "basedir": "/builds/slave/test", 05:56:37 INFO - "nightly_build": "True", 05:56:37 INFO - "buildnumber": 430, 05:56:37 INFO - "slavename": "talos-linux64-ix-030", 05:56:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:56:37 INFO - "platform": "ubuntu64_hw", 05:56:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:56:37 INFO - "branch": "mozilla-central", 05:56:37 INFO - "repo_path": "mozilla-central", 05:56:37 INFO - "revision": "369a5ee3a2880a4a98df3a00bf3db8d8f36b181b", 05:56:37 INFO - "pgo_build": "True", 05:56:37 INFO - "builduid": "ca051577918442339c331ae12a805704", 05:56:37 INFO - "slavebuilddir": "test" 05:56:37 INFO - } 05:56:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:56:37 INFO - Running post-action listener: _resource_record_post_action 05:56:37 INFO - ##### 05:56:37 INFO - ##### Running download-and-extract step. 05:56:37 INFO - ##### 05:56:37 INFO - Running pre-action listener: _resource_record_pre_action 05:56:37 INFO - Running main action method: download_and_extract 05:56:37 INFO - mkdir: /builds/slave/test/build/tests 05:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:37 INFO - https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:56:39 INFO - Downloaded 1361 bytes. 05:56:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:39 INFO - Using the following test package requirements: 05:56:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:56:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:56:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:56:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:39 INFO - u'jsshell-linux-x86_64.zip'], 05:56:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:56:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:56:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:56:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:56:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:56:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:56:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:39 INFO - https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:45 INFO - Downloaded 23879852 bytes. 05:56:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:56:47 INFO - Return code: 0 05:56:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:56:47 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')]} 05:56:47 INFO - https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:50 INFO - Downloaded 23879852 bytes. 05:56:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:56:51 INFO - Return code: 0 05:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:51 INFO - https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:56:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:56:52 INFO - Downloaded 10840152 bytes. 05:56:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:56:53 INFO - Return code: 0 05:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:53 INFO - https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:56:54 INFO - Downloaded 58380512 bytes. 05:56:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:54 INFO - mkdir: /builds/slave/test/properties 05:56:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:56:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:56:54 INFO - Contents: 05:56:54 INFO - build_url:https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:55 INFO - Running post-action listener: _resource_record_post_action 05:56:55 INFO - Running post-action listener: set_extra_try_arguments 05:56:55 INFO - ##### 05:56:55 INFO - ##### Running populate-webroot step. 05:56:55 INFO - ##### 05:56:55 INFO - Running pre-action listener: _resource_record_pre_action 05:56:55 INFO - Running main action method: populate_webroot 05:56:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:56:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:56:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:56:55 INFO - '--tppagecycles', 05:56:55 INFO - '7'], 05:56:55 INFO - 'tests': ['tsvgm']}}, 05:56:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:56:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:56:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:56:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:56:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:56:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:56:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:55 INFO - 'talos_options': ['--disable-e10s'], 05:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:55 INFO - 'talos_options': ['--disable-e10s'], 05:56:55 INFO - 'tests': ['damp', 'tps']}, 05:56:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:55 INFO - 'tests': ['damp', 'tps']}, 05:56:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:56:55 INFO - 'tests': ['dromaeo_dom']}, 05:56:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:56:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:56:55 INFO - 'tests': ['a11yr', 05:56:55 INFO - 'ts_paint', 05:56:55 INFO - 'tpaint', 05:56:55 INFO - 'sessionrestore', 05:56:55 INFO - 'sessionrestore_no_auto_restore', 05:56:55 INFO - 'tabpaint']}, 05:56:55 INFO - 'other-e10s': {'tests': ['a11yr', 05:56:55 INFO - 'ts_paint', 05:56:55 INFO - 'tpaint', 05:56:55 INFO - 'sessionrestore', 05:56:55 INFO - 'sessionrestore_no_auto_restore', 05:56:55 INFO - 'tabpaint']}, 05:56:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:56:55 INFO - 'ts_paint', 05:56:55 INFO - 'tpaint', 05:56:55 INFO - 'sessionrestore', 05:56:55 INFO - 'sessionrestore_no_auto_restore', 05:56:55 INFO - 'tabpaint']}, 05:56:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:56:55 INFO - 'ts_paint', 05:56:55 INFO - 'tpaint', 05:56:55 INFO - 'sessionrestore', 05:56:55 INFO - 'sessionrestore_no_auto_restore', 05:56:55 INFO - 'tabpaint']}, 05:56:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:56:55 INFO - 'tests': ['a11yr', 05:56:55 INFO - 'ts_paint', 05:56:55 INFO - 'tpaint', 05:56:55 INFO - 'sessionrestore', 05:56:55 INFO - 'sessionrestore_no_auto_restore', 05:56:55 INFO - 'tabpaint']}, 05:56:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:56:55 INFO - 'tests': ['a11yr', 05:56:55 INFO - 'ts_paint', 05:56:55 INFO - 'tpaint', 05:56:55 INFO - 'sessionrestore', 05:56:55 INFO - 'sessionrestore_no_auto_restore', 05:56:55 INFO - 'tabpaint']}, 05:56:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:56:55 INFO - 'tests': ['tsvgx', 05:56:55 INFO - 'tsvgr_opacity', 05:56:55 INFO - 'tart', 05:56:55 INFO - 'tscrollx', 05:56:55 INFO - 'cart']}, 05:56:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:56:55 INFO - 'tsvgr_opacity', 05:56:55 INFO - 'tart', 05:56:55 INFO - 'tscrollx', 05:56:55 INFO - 'cart']}, 05:56:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:55 INFO - 'talos_options': ['--disable-e10s'], 05:56:55 INFO - 'tests': ['tp5o']}, 05:56:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:55 INFO - 'tests': ['tp5o']}, 05:56:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:55 INFO - 'talos_options': ['--disable-e10s', 05:56:55 INFO - '--xperf_path', 05:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:55 INFO - 'tests': ['tp5n']}, 05:56:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:55 INFO - 'talos_options': ['--xperf_path', 05:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:55 INFO - 'tests': ['tp5n']}}, 05:56:55 INFO - 'talos.zip': {'path': '', 05:56:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:56:55 INFO - Running post-action listener: _resource_record_post_action 05:56:55 INFO - ##### 05:56:55 INFO - ##### Running create-virtualenv step. 05:56:55 INFO - ##### 05:56:55 INFO - Running pre-action listener: _resource_record_pre_action 05:56:55 INFO - Running main action method: create_virtualenv 05:56:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:56:55 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 05:56:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:56:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:56:55 INFO - Using real prefix '/usr' 05:56:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:56:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:56:59 INFO - Installing pip.................done. 05:56:59 INFO - Return code: 0 05:56:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba5c42ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b810>, '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 0x1f2c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', '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 05:56: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', 'pip>=1.5'] in /builds/slave/test/build 05:56: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 pip>=1.5 05:56:59 INFO - Using env: {'DISPLAY': ':0', 05:56:59 INFO - 'HOME': '/home/cltbld', 05:56:59 INFO - 'LANG': 'en_US.UTF-8', 05:56:59 INFO - 'LANGUAGE': 'en_US:en', 05:56:59 INFO - 'LOGNAME': 'cltbld', 05:56:59 INFO - 'MAIL': '/var/mail/cltbld', 05:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:59 INFO - 'MOZ_NO_REMOTE': '1', 05:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:59 INFO - 'NO_EM_RESTART': '1', 05:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:59 INFO - 'PWD': '/builds/slave/test', 05:56:59 INFO - 'SHELL': '/bin/bash', 05:56:59 INFO - 'SHLVL': '1', 05:56:59 INFO - 'TERM': 'linux', 05:56:59 INFO - 'TMOUT': '86400', 05:56:59 INFO - 'USER': 'cltbld', 05:56:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', 05:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:59 INFO - '_': '/tools/buildbot/bin/python'} 05:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:59 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 05:56:59 INFO - Cleaning up... 05:56:59 INFO - Return code: 0 05:56:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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', '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 0x7fba5c42ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b810>, '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 0x1f2c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', '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 05:56: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:56: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 psutil>=0.7.1 05:56:59 INFO - Using env: {'DISPLAY': ':0', 05:56:59 INFO - 'HOME': '/home/cltbld', 05:56:59 INFO - 'LANG': 'en_US.UTF-8', 05:56:59 INFO - 'LANGUAGE': 'en_US:en', 05:56:59 INFO - 'LOGNAME': 'cltbld', 05:56:59 INFO - 'MAIL': '/var/mail/cltbld', 05:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:59 INFO - 'MOZ_NO_REMOTE': '1', 05:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:59 INFO - 'NO_EM_RESTART': '1', 05:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:59 INFO - 'PWD': '/builds/slave/test', 05:56:59 INFO - 'SHELL': '/bin/bash', 05:56:59 INFO - 'SHLVL': '1', 05:56:59 INFO - 'TERM': 'linux', 05:56:59 INFO - 'TMOUT': '86400', 05:56:59 INFO - 'USER': 'cltbld', 05:56:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', 05:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:59 INFO - '_': '/tools/buildbot/bin/python'} 05:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:59 INFO - Downloading/unpacking psutil>=0.7.1 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:57:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:01 INFO - Installing collected packages: psutil 05:57:01 INFO - Running setup.py install for psutil 05:57:02 INFO - building 'psutil._psutil_linux' extension 05:57:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:57:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:57:03 INFO - building 'psutil._psutil_posix' extension 05:57:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:57:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:57:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:03 INFO - Successfully installed psutil 05:57:03 INFO - Cleaning up... 05:57:03 INFO - Return code: 0 05:57:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:03 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 0x7fba5c42ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b810>, '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 0x1f2c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', '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 05:57:03 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 05:57:03 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 05:57:03 INFO - Using env: {'DISPLAY': ':0', 05:57:03 INFO - 'HOME': '/home/cltbld', 05:57:03 INFO - 'LANG': 'en_US.UTF-8', 05:57:03 INFO - 'LANGUAGE': 'en_US:en', 05:57:03 INFO - 'LOGNAME': 'cltbld', 05:57:03 INFO - 'MAIL': '/var/mail/cltbld', 05:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:03 INFO - 'MOZ_NO_REMOTE': '1', 05:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:03 INFO - 'NO_EM_RESTART': '1', 05:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:03 INFO - 'PWD': '/builds/slave/test', 05:57:03 INFO - 'SHELL': '/bin/bash', 05:57:03 INFO - 'SHLVL': '1', 05:57:03 INFO - 'TERM': 'linux', 05:57:03 INFO - 'TMOUT': '86400', 05:57:03 INFO - 'USER': 'cltbld', 05:57:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', 05:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:03 INFO - '_': '/tools/buildbot/bin/python'} 05:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:57:03 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 05:57:03 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 05:57:03 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 05:57:03 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 05:57:03 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 05:57:03 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 05:57:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:57:05 INFO - Installing collected packages: mozsystemmonitor 05:57:05 INFO - Running setup.py install for mozsystemmonitor 05:57:05 INFO - Successfully installed mozsystemmonitor 05:57:05 INFO - Cleaning up... 05:57:06 INFO - Return code: 0 05:57:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba5c42ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b810>, '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 0x1f2c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', '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 05:57:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:57:06 INFO - Using env: {'DISPLAY': ':0', 05:57:06 INFO - 'HOME': '/home/cltbld', 05:57:06 INFO - 'LANG': 'en_US.UTF-8', 05:57:06 INFO - 'LANGUAGE': 'en_US:en', 05:57:06 INFO - 'LOGNAME': 'cltbld', 05:57:06 INFO - 'MAIL': '/var/mail/cltbld', 05:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:06 INFO - 'MOZ_NO_REMOTE': '1', 05:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:06 INFO - 'NO_EM_RESTART': '1', 05:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:06 INFO - 'PWD': '/builds/slave/test', 05:57:06 INFO - 'SHELL': '/bin/bash', 05:57:06 INFO - 'SHLVL': '1', 05:57:06 INFO - 'TERM': 'linux', 05:57:06 INFO - 'TMOUT': '86400', 05:57:06 INFO - 'USER': 'cltbld', 05:57:06 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', 05:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:06 INFO - '_': '/tools/buildbot/bin/python'} 05:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:57:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:57:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:08 INFO - Downloading docopt-0.6.1.tar.gz 05:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:57:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:57:08 INFO - Running setup.py install for blobuploader 05:57:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:57:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:57:08 INFO - Running setup.py install for requests 05:57:09 INFO - Running setup.py install for docopt 05:57:09 INFO - Successfully installed blobuploader requests docopt 05:57:09 INFO - Cleaning up... 05:57:09 INFO - Return code: 0 05:57:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba5c42ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b810>, '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 0x1f2c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', '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 05:57:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:57:09 INFO - Using env: {'DISPLAY': ':0', 05:57:09 INFO - 'HOME': '/home/cltbld', 05:57:09 INFO - 'LANG': 'en_US.UTF-8', 05:57:09 INFO - 'LANGUAGE': 'en_US:en', 05:57:09 INFO - 'LOGNAME': 'cltbld', 05:57:09 INFO - 'MAIL': '/var/mail/cltbld', 05:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:09 INFO - 'MOZ_NO_REMOTE': '1', 05:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:09 INFO - 'NO_EM_RESTART': '1', 05:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:09 INFO - 'PWD': '/builds/slave/test', 05:57:09 INFO - 'SHELL': '/bin/bash', 05:57:09 INFO - 'SHLVL': '1', 05:57:09 INFO - 'TERM': 'linux', 05:57:09 INFO - 'TMOUT': '86400', 05:57:09 INFO - 'USER': 'cltbld', 05:57:09 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', 05:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:09 INFO - '_': '/tools/buildbot/bin/python'} 05:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:09 INFO - Running setup.py (path:/tmp/pip-8DPqFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:09 INFO - Running setup.py (path:/tmp/pip-0SMtcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:09 INFO - Running setup.py (path:/tmp/pip-x_r7ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:09 INFO - Running setup.py (path:/tmp/pip-QhcyXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:10 INFO - Running setup.py (path:/tmp/pip-76ogNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:10 INFO - Running setup.py (path:/tmp/pip-91qRVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:10 INFO - Running setup.py (path:/tmp/pip-Zmaegt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:10 INFO - Running setup.py (path:/tmp/pip-_C4ISF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:10 INFO - Running setup.py (path:/tmp/pip-yOMjyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:10 INFO - Running setup.py (path:/tmp/pip-CFjshz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:10 INFO - Running setup.py (path:/tmp/pip-eZWPyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:10 INFO - Running setup.py (path:/tmp/pip-xQTK2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:10 INFO - Running setup.py (path:/tmp/pip-h8KkHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:10 INFO - Running setup.py (path:/tmp/pip-9VNvoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:10 INFO - Running setup.py (path:/tmp/pip-cN8IAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:10 INFO - Running setup.py (path:/tmp/pip-BxKLqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:10 INFO - Running setup.py (path:/tmp/pip-IS3rkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:10 INFO - Running setup.py install for manifestparser 05:57:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Running setup.py install for mozcrash 05:57:11 INFO - Running setup.py install for mozdebug 05:57:11 INFO - Running setup.py install for mozdevice 05:57:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Running setup.py install for mozfile 05:57:11 INFO - Running setup.py install for mozhttpd 05:57:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Running setup.py install for mozinfo 05:57:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Running setup.py install for mozInstall 05:57:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Running setup.py install for mozleak 05:57:11 INFO - Running setup.py install for mozlog 05:57:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Running setup.py install for moznetwork 05:57:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Running setup.py install for mozprocess 05:57:12 INFO - Running setup.py install for mozprofile 05:57:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Running setup.py install for mozrunner 05:57:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Running setup.py install for mozscreenshot 05:57:12 INFO - Running setup.py install for moztest 05:57:12 INFO - Running setup.py install for mozversion 05:57:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:12 INFO - Cleaning up... 05:57:12 INFO - Return code: 0 05:57:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:12 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 0x7fba5c42ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b810>, '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 0x1f2c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', '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 05:57:12 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 05:57:12 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 05:57:12 INFO - Using env: {'DISPLAY': ':0', 05:57:12 INFO - 'HOME': '/home/cltbld', 05:57:12 INFO - 'LANG': 'en_US.UTF-8', 05:57:12 INFO - 'LANGUAGE': 'en_US:en', 05:57:12 INFO - 'LOGNAME': 'cltbld', 05:57:12 INFO - 'MAIL': '/var/mail/cltbld', 05:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:12 INFO - 'MOZ_NO_REMOTE': '1', 05:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:12 INFO - 'NO_EM_RESTART': '1', 05:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:12 INFO - 'PWD': '/builds/slave/test', 05:57:12 INFO - 'SHELL': '/bin/bash', 05:57:12 INFO - 'SHLVL': '1', 05:57:12 INFO - 'TERM': 'linux', 05:57:12 INFO - 'TMOUT': '86400', 05:57:12 INFO - 'USER': 'cltbld', 05:57:12 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', 05:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:12 INFO - '_': '/tools/buildbot/bin/python'} 05:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:12 INFO - Running setup.py (path:/tmp/pip-cBTP0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:13 INFO - Running setup.py (path:/tmp/pip-18Z6Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:13 INFO - Running setup.py (path:/tmp/pip-Gr6nEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:13 INFO - Running setup.py (path:/tmp/pip-nicgNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:13 INFO - Running setup.py (path:/tmp/pip-gpzEJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:13 INFO - Running setup.py (path:/tmp/pip-jKuN5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:13 INFO - Running setup.py (path:/tmp/pip-oRDVsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:13 INFO - Running setup.py (path:/tmp/pip-7BT3_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:13 INFO - Running setup.py (path:/tmp/pip-Llyryk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:13 INFO - Running setup.py (path:/tmp/pip-55KwLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:13 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)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:13 INFO - Running setup.py (path:/tmp/pip-ncVxw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:13 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)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:13 INFO - Running setup.py (path:/tmp/pip-bNXBjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:13 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)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:13 INFO - Running setup.py (path:/tmp/pip-Lb5eqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:13 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)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:13 INFO - Running setup.py (path:/tmp/pip-hWiEUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:13 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)) 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:13 INFO - Running setup.py (path:/tmp/pip-QM8Ros-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:14 INFO - Running setup.py (path:/tmp/pip-Ubjvq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:14 INFO - Running setup.py (path:/tmp/pip-utZrbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:16 INFO - Downloading blessings-1.6.tar.gz 05:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:16 INFO - Installing collected packages: blessings 05:57:16 INFO - Running setup.py install for blessings 05:57:16 INFO - Successfully installed blessings 05:57:16 INFO - Cleaning up... 05:57:16 INFO - Return code: 0 05:57:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:16 INFO - Reading from file tmpfile_stdout 05:57:16 INFO - Current package versions: 05:57:16 INFO - argparse == 1.2.1 05:57:16 INFO - blessings == 1.6 05:57:16 INFO - blobuploader == 1.2.4 05:57:16 INFO - docopt == 0.6.1 05:57:16 INFO - manifestparser == 1.1 05:57:16 INFO - mozInstall == 1.12 05:57:16 INFO - mozcrash == 0.17 05:57:16 INFO - mozdebug == 0.1 05:57:16 INFO - mozdevice == 0.48 05:57:16 INFO - mozfile == 1.2 05:57:16 INFO - mozhttpd == 0.7 05:57:16 INFO - mozinfo == 0.9 05:57:16 INFO - mozleak == 0.1 05:57:16 INFO - mozlog == 3.1 05:57:16 INFO - moznetwork == 0.27 05:57:16 INFO - mozprocess == 0.22 05:57:16 INFO - mozprofile == 0.28 05:57:16 INFO - mozrunner == 6.11 05:57:16 INFO - mozscreenshot == 0.1 05:57:16 INFO - mozsystemmonitor == 0.0 05:57:16 INFO - moztest == 0.7 05:57:16 INFO - mozversion == 1.4 05:57:16 INFO - psutil == 3.1.1 05:57:16 INFO - requests == 1.2.3 05:57:16 INFO - wsgiref == 0.1.2 05:57:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba5c42ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b810>, '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 0x1f2c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', '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 05:57:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:57:16 INFO - Using env: {'DISPLAY': ':0', 05:57:16 INFO - 'HOME': '/home/cltbld', 05:57:16 INFO - 'LANG': 'en_US.UTF-8', 05:57:16 INFO - 'LANGUAGE': 'en_US:en', 05:57:16 INFO - 'LOGNAME': 'cltbld', 05:57:16 INFO - 'MAIL': '/var/mail/cltbld', 05:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:16 INFO - 'MOZ_NO_REMOTE': '1', 05:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:16 INFO - 'NO_EM_RESTART': '1', 05:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:16 INFO - 'PWD': '/builds/slave/test', 05:57:16 INFO - 'SHELL': '/bin/bash', 05:57:16 INFO - 'SHLVL': '1', 05:57:16 INFO - 'TERM': 'linux', 05:57:16 INFO - 'TMOUT': '86400', 05:57:16 INFO - 'USER': 'cltbld', 05:57:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', 05:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:16 INFO - '_': '/tools/buildbot/bin/python'} 05:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:16 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)) 05:57:16 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)) 05:57:16 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)) 05:57:16 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)) 05:57:16 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)) 05:57:16 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)) 05:57:16 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)) 05:57:16 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)) 05:57:16 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)) 05:57:16 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)) 05:57:16 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)) 05:57:16 INFO - Cleaning up... 05:57:16 INFO - Return code: 0 05:57:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:16 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 0x7fba5c42ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b810>, '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 0x1f2c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', '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 05:57:16 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 05:57:16 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 05:57:16 INFO - Using env: {'DISPLAY': ':0', 05:57:16 INFO - 'HOME': '/home/cltbld', 05:57:16 INFO - 'LANG': 'en_US.UTF-8', 05:57:16 INFO - 'LANGUAGE': 'en_US:en', 05:57:16 INFO - 'LOGNAME': 'cltbld', 05:57:16 INFO - 'MAIL': '/var/mail/cltbld', 05:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:16 INFO - 'MOZ_NO_REMOTE': '1', 05:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:16 INFO - 'NO_EM_RESTART': '1', 05:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:16 INFO - 'PWD': '/builds/slave/test', 05:57:16 INFO - 'SHELL': '/bin/bash', 05:57:16 INFO - 'SHLVL': '1', 05:57:16 INFO - 'TERM': 'linux', 05:57:16 INFO - 'TMOUT': '86400', 05:57:16 INFO - 'USER': 'cltbld', 05:57:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', 05:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:16 INFO - '_': '/tools/buildbot/bin/python'} 05:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:16 INFO - Downloading/unpacking jsonschema 05:57:16 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 05:57:16 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 05:57:16 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 05:57:16 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 05:57:16 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 05:57:16 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 05:57:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:57:18 INFO - Downloading/unpacking functools32 (from jsonschema) 05:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:57:19 INFO - warning: no files found matching '*.txt' 05:57:19 INFO - no previously-included directories found matching 'build' 05:57:19 INFO - no previously-included directories found matching 'dist' 05:57:19 INFO - no previously-included directories found matching '.git*' 05:57:19 INFO - Installing collected packages: jsonschema, functools32 05:57:19 INFO - Running setup.py install for functools32 05:57:19 INFO - warning: no files found matching '*.txt' 05:57:19 INFO - no previously-included directories found matching 'build' 05:57:19 INFO - no previously-included directories found matching 'dist' 05:57:19 INFO - no previously-included directories found matching '.git*' 05:57:19 INFO - Successfully installed jsonschema functools32 05:57:19 INFO - Cleaning up... 05:57:19 INFO - Return code: 0 05:57:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba5c42ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b810>, '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 0x1f2c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', '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 05:57:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:57:19 INFO - Using env: {'DISPLAY': ':0', 05:57:19 INFO - 'HOME': '/home/cltbld', 05:57:19 INFO - 'LANG': 'en_US.UTF-8', 05:57:19 INFO - 'LANGUAGE': 'en_US:en', 05:57:19 INFO - 'LOGNAME': 'cltbld', 05:57:19 INFO - 'MAIL': '/var/mail/cltbld', 05:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:19 INFO - 'MOZ_NO_REMOTE': '1', 05:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:19 INFO - 'NO_EM_RESTART': '1', 05:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:19 INFO - 'PWD': '/builds/slave/test', 05:57:19 INFO - 'SHELL': '/bin/bash', 05:57:19 INFO - 'SHLVL': '1', 05:57:19 INFO - 'TERM': 'linux', 05:57:19 INFO - 'TMOUT': '86400', 05:57:19 INFO - 'USER': 'cltbld', 05:57:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', 05:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:19 INFO - '_': '/tools/buildbot/bin/python'} 05:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:19 INFO - Downloading/unpacking flake8 05:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:57:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:57:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:22 INFO - no previously-included directories found matching 'docs/_build' 05:57:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:57:22 INFO - Running setup.py install for pep8 05:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:22 INFO - no previously-included directories found matching 'docs/_build' 05:57:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:57:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:57:22 INFO - Cleaning up... 05:57:22 INFO - Return code: 0 05:57:22 INFO - Running post-action listener: _resource_record_post_action 05:57:22 INFO - Running post-action listener: _start_resource_monitoring 05:57:22 INFO - Starting resource monitoring. 05:57:22 INFO - ##### 05:57:22 INFO - ##### Running install step. 05:57:22 INFO - ##### 05:57:22 INFO - Running pre-action listener: _resource_record_pre_action 05:57:22 INFO - Running main action method: install 05:57:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:22 INFO - Reading from file tmpfile_stdout 05:57:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:22 INFO - Reading from file tmpfile_stdout 05:57:22 INFO - Output received: 05:57:22 INFO - Usage: mozinstall [options] installer 05:57:22 INFO - Options: 05:57:22 INFO - -h, --help show this help message and exit 05:57:22 INFO - -d DEST, --destination=DEST 05:57:22 INFO - Directory to install application into. [default: 05:57:22 INFO - "/builds/slave/test"] 05:57:22 INFO - --app=APP Application being installed. [default: firefox] 05:57:22 INFO - mkdir: /builds/slave/test/build/application 05:57:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:57:39 INFO - Reading from file tmpfile_stdout 05:57:39 INFO - Output received: 05:57:39 INFO - /builds/slave/test/build/application/firefox/firefox 05:57:39 INFO - Running post-action listener: _resource_record_post_action 05:57:39 INFO - ##### 05:57:39 INFO - ##### Running run-tests step. 05:57:39 INFO - ##### 05:57:39 INFO - Running pre-action listener: _resource_record_pre_action 05:57:39 INFO - Running main action method: run_tests 05:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:39 INFO - Python 2.7.3 05:57:39 INFO - Return code: 0 05:57:39 INFO - grabbing minidump binary from tooltool 05:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:39 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 0x1f2b810>, '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 0x1f2c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:39 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 05:57:39 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 05:57:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:39 INFO - Return code: 0 05:57:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:57:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:57:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:57:40 INFO - Return code: 0 05:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 05:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 05:57:40 INFO - Using env: {'DISPLAY': ':0', 05:57:40 INFO - 'HOME': '/home/cltbld', 05:57:40 INFO - 'LANG': 'en_US.UTF-8', 05:57:40 INFO - 'LANGUAGE': 'en_US:en', 05:57:40 INFO - 'LOGNAME': 'cltbld', 05:57:40 INFO - 'MAIL': '/var/mail/cltbld', 05:57:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:40 INFO - 'MOZ_NO_REMOTE': '1', 05:57:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:40 INFO - 'NO_EM_RESTART': '1', 05:57:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:40 INFO - 'PWD': '/builds/slave/test', 05:57:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:40 INFO - 'SHELL': '/bin/bash', 05:57:40 INFO - 'SHLVL': '1', 05:57:40 INFO - 'TERM': 'linux', 05:57:40 INFO - 'TMOUT': '86400', 05:57:40 INFO - 'USER': 'cltbld', 05:57:40 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228', 05:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:40 INFO - '_': '/tools/buildbot/bin/python'} 05:57:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 05:57:40 INFO - mozversion application_buildid: 20160505030327 05:57:40 INFO - mozversion application_changeset: 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b 05:57:40 INFO - mozversion application_display_name: Nightly 05:57:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:40 INFO - mozversion application_name: Firefox 05:57:40 INFO - mozversion application_remotingname: firefox 05:57:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:57:40 INFO - mozversion application_vendor: Mozilla 05:57:40 INFO - mozversion application_version: 49.0a1 05:57:40 INFO - mozversion platform_buildid: 20160505030327 05:57:40 INFO - mozversion platform_changeset: 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b 05:57:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:57:40 INFO - mozversion platform_version: 49.0a1 05:57:40 INFO - using testdate: 1462453060 05:57:40 INFO - actual date: 1462453060 05:57:40 INFO - starting webserver on 'localhost:55510' 05:57:40 INFO - SUITE-START | Running 2 tests 05:57:40 INFO - TEST-START | dromaeo_css 05:57:40 INFO - operating with platform_type : linux_ 05:57:40 INFO - Initialising browser for dromaeo_css test... 05:57:40 INFO - TEST-INFO | started process 3292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqJhee7/profile http://localhost:55510/getInfo.html) 05:57:46 INFO - PROCESS | 3292 | __metrics Screen width/height:1600/1200 05:57:46 INFO - PROCESS | 3292 | colorDepth:24 05:57:46 INFO - PROCESS | 3292 | Browser inner width/height: 1024/697 05:57:46 INFO - PROCESS | 3292 | __metrics 05:57:47 ERROR - PROCESS | 3292 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:57:48 INFO - TEST-INFO | 3292: exit 0 05:57:48 INFO - Browser initialized. 05:57:48 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:48 INFO - TEST-INFO | started process 3375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqJhee7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:00 INFO - PROCESS | 3375 | RSS: Main: 154304512 05:58:00 INFO - PROCESS | 3375 | 05:58:51 INFO - PROCESS | 3375 | 1462453131486 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] 06:00:59 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:55510/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55510/tests/dromaeo/cssquery-ext.html) 06:01:00 INFO - PROCESS | 3375 | RSS: Main: 242843648 06:01:00 INFO - PROCESS | 3375 | 06:04:02 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:55510/tests/dromaeo/cssquery-ext.html (next: http://localhost:55510/tests/dromaeo/cssquery-jquery.html) 06:04:03 INFO - PROCESS | 3375 | RSS: Main: 238321664 06:04:03 INFO - PROCESS | 3375 | 06:07:04 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:55510/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55510/tests/dromaeo/cssquery-mootools.html) 06:07:05 INFO - PROCESS | 3375 | RSS: Main: 241414144 06:07:05 INFO - PROCESS | 3375 | 06:10:07 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:55510/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55510/tests/dromaeo/cssquery-prototype.html) 06:10:08 INFO - PROCESS | 3375 | RSS: Main: 236027904 06:10:08 INFO - PROCESS | 3375 | 06:13:10 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:55510/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55510/tests/dromaeo/cssquery-yui.html) 06:13:11 INFO - PROCESS | 3375 | RSS: Main: 228069376 06:13:11 INFO - PROCESS | 3375 | 06:16:13 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:55510/tests/dromaeo/cssquery-yui.html (next: http://localhost:55510/tests/dromaeo/cssquery-dojo.html) 06:16:14 INFO - PROCESS | 3375 | RSS: Main: 274010112 06:16:14 INFO - PROCESS | 3375 | 06:16:14 INFO - PROCESS | 3375 | __start_tp_report 06:16:14 INFO - PROCESS | 3375 | _x_x_mozilla_page_load 06:16:14 INFO - PROCESS | 3375 | _x_x_mozilla_page_load_details 06:16:14 INFO - PROCESS | 3375 | |i|pagename|runs| 06:16:14 INFO - PROCESS | 3375 | |0;dojo.html;3069.7851150419474;3122.687731226876;3131.655517893031;3149.3228955774503;3183.474726670099;5175.223716442535;5263.0263401270795;5267.63126581139;5305.310309659743;5352.384475785281;5206.5834733221345;5258.605604579662;5265.210218467222;5306.814261500848;5313.043652142613;4728.40894888139;4731.739754313511;4742.881427964311;4757.0723708876785;4915.164422048242;4824.300476430915;4880;4889.217725163974;4890.364252647151;4909.7545122743895;4669.229577119771;4673.042026384583;4770.7376094314795;4794.9280760788615;4834.661573689843;4720.079584481027;4737.905241895177;4739.123262196505;4745.620350371962;4781.330613714083;4732;4733.148033353995;4738.312944623045;4740.762961851928;4757.524247575249;5049.166887463564;5100.566451851597;5131.846044618667;5230.08473517133;5230.660007099526;5607.383187849333;5610.382857885629;5625.184348269478;5639.6334238274385;5641.633293835928;5682.289713785777;5700.37295897451;5705.372409035002;5705.4579814917515;5708;5186.299849520305;5295.576353891718;5354.036273470812;5401.567874570025;5403.4866687665;5787.276590426197;5791.189233507228;5795.855103622359;5796.652200867961;5838.095095260242;5255.658382205144;5514.972425137848;5519.558435325244;5521.00621888064;5524.751386187631;5466.945330546723;5543.833684989457;5567.972160139173;5595.804146854922;5610.4670056344585;5563.860903477364;5576.275084239104;5587.55299576041;5590.860228494239;5592.077307244341;5483.040467918098;5609.411011843697;5609.971950140223;5630.5495560355075;5637.605367624227;4309.719868208619;4309.978450107792;4319.136172765459;4322.394864718942;4355.825766969349;3786.4888240087785;3794.051487128218;3801.2967600993907;3829.3872980323013;3848.9615103849164;5154.690718556899;5248.947510524922;5324.733763311819;5332.2801421808335;5340.839774806762;5624.072028115315;5646.463585959327;5659.858503537444;5682.176084467729;5701.230333904953;5283.260343551906;5304.681719096867;5306;5323.574114070865;5334.039872822852;4660.207764680013;4711.95288047122;4717.363155973968;4779.115863565252;4804.303376010529;5763.337216220105;5766.192733017381;5766.221560089334;5807.709614519257;5839.737211825478;5573.609847310811;5580.748866301107;5582.106862901916;5589.273394458694;5596.496315331639;5758.798442054508;5771.163181338598;5798.072308430631;5883.911741323798;5897.882042359214;5603.719814009365;5604.103343465026;5608.4111168326735;5608.663480191201;5616.241807356118;5680.77276908919;5705.771769129188;5713.143028545752;5721.256236689203;5721.570882183936;5429.131338985743;5569.08110161835;5612.102063669793;5647;5660;5548.056830338933;5570.5265052470995;5570.972145139411;5571.4428557143965;5583.274174357308;5287.841364759063;5442.319710036246;5486.149646804752;5504.6421982571;5559.8888022240135;5501.174823776466;5550.084236100998;5560.91658625129;5580.972095139498;5604.187392828098;5478.658308149522;5516.14499752539;5519.144532597454;5524.254225679642;5550.08423610116 06:16:14 INFO - PROCESS | 3375 | |1;ext.html;643.1992169748663;651.6285717141228;657.0308794528069;663.8274048747326;674.1034424215792;37972.96216302696;39695.404568931415;39802.80098599507;39808.2038359233;39944.20111597767;45426;46170.307445388346;46201.53798462015;46225.768871155684;46238.53761462384;8850.159234872694;9126.406783559081;9127.68053118141;9134.132257435533;9139.543022848831;8978.416402933788;9106.544672766368;9118.270538356915;9121.224695900857;9125.589348479334;9131.178193962542;9156;9166.587503562356;9208.401453905508;9215.262778977665;9047.864282035775;9135.725928222164;9142.908570914273;9155.725328240096;9157.908420915806;8951.865722014176;9075;9077.228435582983;9081.682141125095;9087.227585655228;42125;42494;42702.35946460805;42764.358534622006;42767.144657106684;3540.8583656653705;3979.303621866162;3980.2835489611857;4216.536181020086;4541.545845415465;33002.83498582516;33316.50025249599;33513.86935575572;33548;33592.32815343704;4125.133721918371;4224.134052519257;4225.3873188387815;4257.701960862741;4285.442892423996;319597;321253;321544;321713;322386.9999999977;47682.761586192544;52995.47004529982;54436;61384;61971.38028619656;56571.717141414854;56804.71597641985;56867.715661422255;56906.71546642323;57011.429885701444;16633.417830375878;16908.830911690973;16935.0685712287;16941.745873811902;16946.152692365333;11733.765324693459;11960.461779219955;12401.317927514074;12677.239365638092;12816.935915320364;17473.56316092108;17739.911300443673;17956;18063.458096257134;18088.457346279632;6527.477801775942;6561.573497722633;6698.363655452724;6743.966280168666;6796.558223715443;1034.8085604163255;1052.1057101463696;1136.91992607022;1141.9143564232716;1225.1424003197797;32357.51463728046;32947.3410531788;33249;33554.66445335515;33633.663663363055;1190.922590031645;1203.0435803536209;1209.1717173735842;1219.0613227814533;1232.9260244385366;17568;17683.646327073642;17756.644867102586;17848.286068557372;17901;292328;300477;301421;301869;450438;52742.73628631832;52744.73627631837;53124.46875531195;53380.73309633427;53415.19877201845;1388.1393536007538;1458.3145921416917;1465.4284828916732;1467.3690313165228;1478.0835881753383;30878.84560577183;32899;33053.37252784564;33186.17034574155;33765.32469350648;50482;50993.23510147425;51001;51013.48986510236;51053.489465104874;242941;344403;350785;351245;351967;26331.736682632927;26595.468090638467;26824.06115786016;27008.459830803666;27259;41899.7905010473;42721.14557708891;42886.356704650076;43385.78307108444;43816.342754858066;39437.80281098576;39584.60415395809;40417.1916561673;40808.183836323704;40871.59128408797;38440.80779596196;39326;39681.40477892776;39988.800895928835;40849.1830163401;40324.59675403326;40623.59376406198;40734.796326019365;41514.58485415107;41519;34080.48879266863;35182;35873.46189807207;36243.63756362403;36570.45144322784;27861.16416507508;28065.579016314365;28130.71869281281;28195.47370313461;28263.43473130567 06:16:14 INFO - PROCESS | 3375 | |2;jquery.html;391.90986073203146;393.66735108833046;396.9523657161141;398.22743876878855;414.34326592351124;14152;17806.910965445153;18177.63644727105;18701.719474207897;18764.437066887996;16300.26648800804;16530.256138473767;16535.586610334747;17512.036837973905;17666.823331766678;5597.160425936101;5614.9157762633495;5759.5968282220265;5774.3936886626925;5800.245968024151;4083.183363327332;5710.2862142232225;5728.885422291552;5762.164486149527;6038.27540695115;6227.470664993459;6253.1870856788555;6254.593451425642;6271.435570798627;6283.277423096357;6192.876142477147;6232.3144454110015;6238.5944913580925;6249.656268905208;6270.278917924452;5420.13277875538;5528.087865502187;5536.197251398565;5538.972305138489;5550.417206193332;20624.484387890272;21709.67435488469;22254.777452225433;22292.55414891693;22337.32988010362;2421.225207933462;2506.448581312127;2627.2906315294763;2815.4650616382824;3165.082126183404;13879.722405551833;13902;13918.234497102656;14161.929190354085;14292.356843941943;1914.4352416037163;1932.232007712941;1990.9303174388972;2022.1203776357186;2080.78151794061;76701;76707;77712;78199;78972.60513697394;10179.796404071878;10299.691009269734;10542.736431589272;10603.787924241473;10791.082757965503;13215.537456188988;13619.659508512366;14824.851751482347;14843.851561484247;14845.480408185662;7647.808804779814;7663.233676632403;7726.536407815549;7885.842283154305;7952.681892724342;7432;7708.113566939874;7717.729879454192;7795.922040779633;7860.567668778158;6441;6553.934460655428;6660.766873159416;6683.565568238049;6739.865202695919;1798.7301904714398;1886.4340697790883;1908.780490243612;1916;1942.854285928561;1041.5261056219401;1066.173715370594;1074.5272080284649;1075.473018221066;1143.9656810295705;18108.185131669106;18778.906105469658;19156.137973791214;19175.61648767017;19315.80684193168;1079.9244052916379;1106.8284415915546;1119.2333251722596;1139.458757090392;1161.8663853656938;10710.303830251165;11029.779404412027;11056.778864422666;11088.501017454233;11117.332960022424;452331;455525;504706;509687.160949365;516715;80023.59988200021;82623;87107;92597;97821.51089244508;1066.8506409102731;1108.9001989820954;1110.7889500994786;1117.234694234452;1123;16554.83445165533;16816.663666726352;16857.578560536083;16867;17421.912890435466;35113.648863511036;39439.2112157761;40459.59540404676;41385.58614413817;41389.793051034554;43497.13005739804;47899.52100478951;48274;48986.26520602123;49114;8596.613152408281;8675.175858293453;8701.884313315484;8822.602982865657;8891.955540222258;8562.91437085646;9495.796235212476;11642;13378.732425351633;13454.596362109152;11597.536098555964;11976.940115299367;12178.939105304416;12196.085293603193;12400.62798116058;11564;11670.649880503599;11749.29504229749;11779.116566257393;11899.46452409661;6490.740370385131;9999.3000489965;12056.75886482248;12135.301057851731;12221.633350999484;8684.692373726768;8718.433301835614;8744.825103497767;8828.690995815115;8888.466691998501;9125.908740912506;11627.883721163018;12187.573434929735;12305.753884922431;12310.322932238812 06:16:14 INFO - PROCESS | 3375 | |3;mootools.html;1373.4849431463201;1505.691333276678;1524.0322395278997;1642.4744081893798;1758.947231583053;7450.925490745091;7710.807229819244;7723.150453450123;7723.884141737872;7724.922750772491;7550.395968322535;7714.498557593753;7733.497322674022;7734.265244801749;7735.1491335953;1984.5038740314922;2047.6109539187507;2050.077465140685;2273.056681477185;2302.9193978210765;2234.486068204314;2304.665823455606;2305.8962346694357;2308.6998690170253;2309.1225334372916;2244.9438764030865;2261.1407665087327;2271.954560908781;2273.624851899435;2282.1784157703214;1988.7215789789295;2175.216921908112;2224.71078759761;2230.408941630461;2230.553889222154;2282.08716513396;2300.861948283108;2302.769723027684;2305.0549274797254;2306.4579823741406;7681.57751323677;7731.613419329067;7744.7289344873225;7745.690172393098;7746.651400686983;4693.530646935314;4871.610271178297;4872.902541949176;4873.853784386474;4881.1213981483315;2988.8505574721394;3144.795588286754;3309.172706823294;3329.6170940341685;3329.916752081193;1061.7557961668783;1068.9625863094755;1077.6605369308643;1130.5867665418227;1144.4506636814292;10670;10722;10729.78540429187;10745.731356716067;10757.246992710514;4168.541460439349;4293.506246781598;4366;4366.672499562545;4369.148016136823;9098.454092754457;9130.452172869649;9138.497382644018;9144.679936202201;9145.908540914506;4828.517148285144;4861.149298872683;4879.926801097987;4952.801887924515;4974.32846565709;4086.6526345260986;4392.472903251566;4510.075434535912;4547.295169248771;4551.385562949025;3668.5414323209598;3729.589745128034;3787.981060094682;3791.2227993261317;3811.2949104415216;1213.0659392267905;1222.2788554752738;1224.1247508031622;1227.5089964014287;1237.3503910446907;1030.1707125763833;1035.699647102332;1042.723678225271;1047.5652604169184;1071.1912506057877;5395.568354531628;5493.066178749622;5520.558355331564;5556.472135147154;5690.943090569124;453.866109497699;459.73105733146485;461.9792109355087;468.28820193305984;471.10725175791686;3982.5021872265966;4102.364133559303;4117.526484454326;4142.668586513072;4187.43469631602;9263.16631503168;9342.205912497513;9671.17794987434;9754.122129008281;9779.559919803625;9550.044995500533;9595.760105997266;9619.663311784054;9621.374610650286;9659.372140810965;7329.780106596811;7404.555726656418;7489.438292128003;7534.284242996907;7535.284148005931;5563.360213575329;5588.105903055492;5696.430356964271;5739.598228123991;5817.389174136655;8605.397622166389;8788.07725188846;8792.604332805167;8881.156290152425;8927.776805579913;8617.784555386166;8855.955720221358;8901.33240006989;8966.551672416223;9212.124848139416;6596.439302659328;6833.3166683331265;6856.108705868205;7022.613756243456;7061.082059332254;7503.399728021855;7537.170911199873;7598.240175982358;7604.049493813273;7612.961935190288;6576.145101136822;6744.69648865812;6750.898736518858;6861.55399899005;6900.309969003059;6810.489213309121;6811.89782153278;6847.760328388483;6947.513674042769;6984.615846128511;6495;6581.3747693969;6606.900896486461;6676.732930682719;6681.098051763144;4725.2203386442225;4864.586510146677;4890;4911.8280860169725;4977.800887964441;4708.905821883474;4821.855344339676;4853.223484242504;4882.292067650242;4950.034743225036 06:16:14 INFO - PROCESS | 3375 | |4;prototype.html;321.36851087612837;329.5962446003645;332.46473178183123;333.88814747059735;333.979961202328;5034.647574669774;5111.56551693106;5116.669665886869;5138.409082955462;5147.433782283951;5038.7984480620735;5049.798008079672;5060;5069.062223488657;5075.593952483801;3809.476209516202;3858.459815625815;3984.3625019996807;3984.581618930014;3995.960040399588;3989.4414781930554;3999.6200360965663;4004.299247631667;4005.379166229239;4014.3777714454304;3788.1476667749675;3940.113474468236;3945.7435266707716;3951.4467974483596;3957.228340473609;3849.2109117630816;3945.5857135000842;3960.861369852041;3965.662918651918;3987.5613682494904;3519.348920449725;3521.753477256593;3536.6816986471085;3545.929081418383;3559.2169722660974;4838.95161048392;4843.733594652293;4851.660383773137;4853.660243782937;4865.807877070105;4409.5149533551285;4554.567316104964;4580.5190455002075;4581.816727330903;4592.288195329729;5278.551323137538;5298;5314.73426328682;5323.733813309319;5324.535752668008;3925.8625948091967;3930.21395720857;3940.9211815763524;3956.188981258835;3965.920681586381;5388.7367305731295;5490.80782172622;5563.527100196488;5576.219329293902;5587.1339942309005;3986.123052928351;4006.2187873364996;4010.1578668479365;4015.217032678658;4015.638592526687;4072.490938632671;4073.6741060715663;4074.348104303297;4084.4485994390375;4106.938395924063;4436.223660859337;4592.816287348535;4596.931046034312;4606.470255920545;4615.769211539409;5364.463553644604;5376.78492860289;5384;5400.9459905400445;5418.938299860566;1482.2366481262159;1490.8360080391149;1495.244901324824;1497.1989985357782;1497.4650982742558;963.9325247232626;996.4021587047713;996.4121168510469;1011.8768167334254;1044.2637940252105;5396.21754845553;5436.293281873332;5481.205225242317;5492.187578099218;5494.8076817312;5794.768209271582;5822.592418530747;5832.096025116114;5842.328132264844;5842.707864606753;5311.389190243094;5416.593755468356;5492.258545096441;5493.945060549343;5495.2856128703015;3063.831489268067;3083.722464978163;3088.8301143437325;3090.8454577271045;3108.5026395776567;5464.726763661801;5957.910631340534;6025.307089684655;6038.486728628028;6042.335343112254;5680.233168522279;5693.857653558612;5700.60813815779;5702.54379649627;5721.370649228582;5725.2843394575675;5732.598718089694;5741.339745929272;5758.971205143947;5777.653340799566;5436.429174936733;5519.095594545462;5599.860003499945;5609.719514024364;5627.409122042291;5533.916991245215;5551.972885016285;5560.749766260447;5565.276514053147;5567.5246059795;5601.60788744784;5761.695321871285;5789.942100579109;5799.884002320015;5823.82528524145;3947.480220115334;3973.6821054316165;3985.282649123186;3989.7207195496035;3992.1416895367634;5515.862103447446;5527.281453411031;5537.307836520435;5541.174001259306;5558.221848941233;5268.81559145428;5451.972740136274;5453.890922181614;5454.9727251365075;5466.562674985912;5397.271368365377;5402.243685883901;5426.430224826337;5427.050266203478;5447.264619276347;5067.163917953497;5170.948290517047;5319.973400132974;5347.973260133675;5365.8000219909645;5408.648437851527;5416.241726158262;5423.566114710892;5427.290403522878;5438.646487978269;5303.549198318186;5323.973380133075;5326.707031113326;5341.332333458317;5350.983313170485 06:16:14 INFO - PROCESS | 3375 | |5;yui.html;737.5206116024583;800.1558355934488;830.4767996162417;851.795569063425;890.1009979920283;14189.929050354747;14234.71530569388;14547.345369458373;14571.052881562704;14597;14153.15081095135;14292.07101538402;14310.570682879505;14310.642233944156;14313.71372572548;682.2529330383222;705.6436499567711;709.38283693187;710.6482291265805;819.5574389829485;835.7200337886816;847.855864503036;848.8302339532088;849.8597731374316;849.8810166576684;870.9912900870974;881.4579033894173;881.8633111867671;882.4220135811054;882.6072397782989;716.924722904098;850.4344610833788;862.8058686795483;872.7992561710779;893.5398269890946;641.1952998986243;644.1111266452313;647.5596594315863;647.8769033883547;648.5946283572767;13394.866051339459;13439.462421503225;13453.05828591999;13463.394147263396;13474.393652285671;13615.795763063563;14080.647983800385;14154.92922535391;14192.929035354757;14275.21486318252;11704.77609254239;11867.287962722265;11937.522499100025;11984.760304793856;12224.449899754443;3841.2125514269787;3880.708946828999;3959.881203563869;3997.34043882759;4048.1701251243426;54832;55567.72216138934;57466.71266643682;57796;57932.420675793124;10671.786564268672;10759.193060520493;10973;10979.560817567208;11308.321500709984;18762.530936726416;19363.709544356847;20942;21011.894940525504;21025.369238922856;8617.209622947516;8800.295976322006;8850.424722393023;8852.690155844643;8906.109389061043;4936.8765780855765;4940.975295123501;4950.925736113961;5055.216441451581;5069.188929771292;3394.762366634312;3453.309338132384;3485.0938755923644;3489.1451594359546;3496.930061398758;580.4021857486796;651.947844172465;658.285167139604;659.2089492608889;659.3011407907633;534.8555889909702;662.2814246542555;684.8116767888771;756.1946526948782;781.4725060584196;8959;9295.395799273025;9340.906590934139;9341.34610577253;9446.929747831982;682.3994884501607;724.5543990445838;764.3388468974408;778.8442311537715;785.2540086917451;4312.266914624522;4375.912481750347;4477.708948918375;4512.571305725951;4564.931526027112;55000.449995500334;56934.7153264231;57128.71435642878;61993.110654487755;62116.689416553534;53209;54487.45512544903;56519.43480565224;57006.14490782641;58337;50195.24707129396;51218;52152.21771673428;52679.47320526746;53054;8494.27798637098;8802.339824513316;8947.463152210888;9059.320550958837;9182.506291090891;33226.169345766546;34305;34319.4852077214;34604.480932785526;35414.63560961704;44604;44787;44848;44950.325745114504;45688.31467527923;11849.348285844017;12023.158378913393;12034.277943323428;12218.20581662189;12270.509179632714;13009.544665936646;13040.152390094614;13251.271180085188;13298.601041968757;13299.800502992657;11374.601888933848;11498.08015358786;11911.225770324902;12075.698107547381;12200.755984880076;12275.631731048083;12293.75412491763;12344.567940122053;12641.3679316032;12737.426815793126;12526.561570344995;12778.488860445477;12931.094823362275;12945.54690585825;13342.533011344556;9766;10242.948785256027;11337.093032557541;11535.769284614093;11581.710457238636;10392.37645741258;10398.376097434179;10487.947560262455;10862.185336099667;10902.78194436091 06:16:14 INFO - PROCESS | 3375 | __end_tp_report 06:16:14 INFO - PROCESS | 3375 | __start_cc_report 06:16:14 INFO - PROCESS | 3375 | _x_x_mozilla_cycle_collect,800 06:16:14 INFO - PROCESS | 3375 | __end_cc_report 06:16:14 INFO - PROCESS | 3375 | __startTimestamp1462454174094__endTimestamp 06:16:14 INFO - PROCESS | 3375 | 06:16:14 INFO - PROCESS | 3375 | ------- Summary: start ------- 06:16:14 INFO - PROCESS | 3375 | Number of tests: 6 06:16:14 INFO - PROCESS | 3375 | 06:16:14 INFO - PROCESS | 3375 | [#0] dojo.html Cycles:165 Average:5232.92 Median:5486.15 stddev:594.16 (10.8%) stddev-sans-first:571.24 06:16:14 INFO - PROCESS | 3375 | Values: 3069.8 3122.7 3131.7 3149.3 3183.5 5175.2 5263.0 5267.6 5305.3 5352.4 5206.6 5258.6 5265.2 5306.8 5313.0 4728.4 4731.7 4742.9 4757.1 4915.2 4824.3 4880.0 4889.2 4890.4 4909.8 4669.2 4673.0 4770.7 4794.9 4834.7 4720.1 4737.9 4739.1 4745.6 4781.3 4732.0 4733.1 4738.3 4740.8 4757.5 5049.2 5100.6 5131.8 5230.1 5230.7 5607.4 5610.4 5625.2 5639.6 5641.6 5682.3 5700.4 5705.4 5705.5 5708.0 5186.3 5295.6 5354.0 5401.6 5403.5 5787.3 5791.2 5795.9 5796.7 5838.1 5255.7 5515.0 5519.6 5521.0 5524.8 5466.9 5543.8 5568.0 5595.8 5610.5 5563.9 5576.3 5587.6 5590.9 5592.1 5483.0 5609.4 5610.0 5630.5 5637.6 4309.7 4310.0 4319.1 4322.4 4355.8 3786.5 3794.1 3801.3 3829.4 3849.0 5154.7 5248.9 5324.7 5332.3 5340.8 5624.1 5646.5 5659.9 5682.2 5701.2 5283.3 5304.7 5306.0 5323.6 5334.0 4660.2 4712.0 4717.4 4779.1 4804.3 5763.3 5766.2 5766.2 5807.7 5839.7 5573.6 5580.7 5582.1 5589.3 5596.5 5758.8 5771.2 5798.1 5883.9 5897.9 5603.7 5604.1 5608.4 5608.7 5616.2 5680.8 5705.8 5713.1 5721.3 5721.6 5429.1 5569.1 5612.1 5647.0 5660.0 5548.1 5570.5 5571.0 5571.4 5583.3 5287.8 5442.3 5486.1 5504.6 5559.9 5501.2 5550.1 5560.9 5581.0 5604.2 5478.7 5516.1 5519.1 5524.3 5550.1 06:16:14 INFO - PROCESS | 3375 | 06:16:14 INFO - PROCESS | 3375 | [#1] ext.html Cycles:180 Average:50186.97 Median:39876.20 stddev:86178.37 (216.1%) stddev-sans-first:86339.84 06:16:14 INFO - PROCESS | 3375 | Values: 643.2 651.6 657.0 663.8 674.1 37973.0 39695.4 39802.8 39808.2 39944.2 45426.0 46170.3 46201.5 46225.8 46238.5 8850.2 9126.4 9127.7 9134.1 9139.5 8978.4 9106.5 9118.3 9121.2 9125.6 9131.2 9156.0 9166.6 9208.4 9215.3 9047.9 9135.7 9142.9 9155.7 9157.9 8951.9 9075.0 9077.2 9081.7 9087.2 42125.0 42494.0 42702.4 42764.4 42767.1 3540.9 3979.3 3980.3 4216.5 4541.5 33002.8 33316.5 33513.9 33548.0 33592.3 4125.1 4224.1 4225.4 4257.7 4285.4 319597.0 321253.0 321544.0 321713.0 322387.0 47682.8 52995.5 54436.0 61384.0 61971.4 56571.7 56804.7 56867.7 56906.7 57011.4 16633.4 16908.8 16935.1 16941.7 16946.2 11733.8 11960.5 12401.3 12677.2 12816.9 17473.6 17739.9 17956.0 18063.5 18088.5 6527.5 6561.6 6698.4 6744.0 6796.6 1034.8 1052.1 1136.9 1141.9 1225.1 32357.5 32947.3 33249.0 33554.7 33633.7 1190.9 1203.0 1209.2 1219.1 1232.9 17568.0 17683.6 17756.6 17848.3 17901.0 292328.0 300477.0 301421.0 301869.0 450438.0 52742.7 52744.7 53124.5 53380.7 53415.2 1388.1 1458.3 1465.4 1467.4 1478.1 30878.8 32899.0 33053.4 33186.2 33765.3 50482.0 50993.2 51001.0 51013.5 51053.5 242941.0 344403.0 350785.0 351245.0 351967.0 26331.7 26595.5 26824.1 27008.5 27259.0 41899.8 42721.1 42886.4 43385.8 43816.3 39437.8 39584.6 40417.2 40808.2 40871.6 38440.8 39326.0 39681.4 39988.8 40849.2 40324.6 40623.6 40734.8 41514.6 41519.0 34080.5 35182.0 35873.5 36243.6 36570.5 27861.2 28065.6 28130.7 28195.5 28263.4 06:16:14 INFO - PROCESS | 3375 | 06:16:14 INFO - PROCESS | 3375 | [#2] jquery.html Cycles:180 Average:28298.53 Median:2463.84 stddev:80340.60 (3260.8%) stddev-sans-first:80538.65 06:16:14 INFO - PROCESS | 3375 | Values: 391.9 393.7 397.0 398.2 414.3 14152.0 17806.9 18177.6 18701.7 18764.4 16300.3 16530.3 16535.6 17512.0 17666.8 5597.2 5614.9 5759.6 5774.4 5800.2 4083.2 5710.3 5728.9 5762.2 6038.3 6227.5 6253.2 6254.6 6271.4 6283.3 6192.9 6232.3 6238.6 6249.7 6270.3 5420.1 5528.1 5536.2 5539.0 5550.4 20624.5 21709.7 22254.8 22292.6 22337.3 2421.2 2506.4 2627.3 2815.5 3165.1 13879.7 13902.0 13918.2 14161.9 14292.4 1914.4 1932.2 1990.9 2022.1 2080.8 76701.0 76707.0 77712.0 78199.0 78972.6 10179.8 10299.7 10542.7 10603.8 10791.1 13215.5 13619.7 14824.9 14843.9 14845.5 7647.8 7663.2 7726.5 7885.8 7952.7 7432.0 7708.1 7717.7 7795.9 7860.6 6441.0 6553.9 6660.8 6683.6 6739.9 1798.7 1886.4 1908.8 1916.0 1942.9 1041.5 1066.2 1074.5 1075.5 1144.0 18108.2 18778.9 19156.1 19175.6 19315.8 1079.9 1106.8 1119.2 1139.5 1161.9 10710.3 11029.8 11056.8 11088.5 11117.3 452331.0 455525.0 504706.0 509687.2 516715.0 80023.6 82623.0 87107.0 92597.0 97821.5 1066.9 1108.9 1110.8 1117.2 1123.0 16554.8 16816.7 16857.6 16867.0 17421.9 35113.6 39439.2 40459.6 41385.6 41389.8 43497.1 47899.5 48274.0 48986.3 49114.0 8596.6 8675.2 8701.9 8822.6 8892.0 8562.9 9495.8 11642.0 13378.7 13454.6 11597.5 11976.9 12178.9 12196.1 12400.6 11564.0 11670.6 11749.3 11779.1 11899.5 6490.7 9999.3 12056.8 12135.3 12221.6 8684.7 8718.4 8744.8 8828.7 8888.5 9125.9 11627.9 12187.6 12305.8 12310.3 06:16:14 INFO - PROCESS | 3375 | 06:16:14 INFO - PROCESS | 3375 | [#3] mootools.html Cycles:180 Average:5250.58 Median:4876.89 stddev:2845.81 (58.4%) stddev-sans-first:2838.88 06:16:14 INFO - PROCESS | 3375 | Values: 1373.5 1505.7 1524.0 1642.5 1758.9 7450.9 7710.8 7723.2 7723.9 7724.9 7550.4 7714.5 7733.5 7734.3 7735.1 1984.5 2047.6 2050.1 2273.1 2302.9 2234.5 2304.7 2305.9 2308.7 2309.1 2244.9 2261.1 2272.0 2273.6 2282.2 1988.7 2175.2 2224.7 2230.4 2230.6 2282.1 2300.9 2302.8 2305.1 2306.5 7681.6 7731.6 7744.7 7745.7 7746.7 4693.5 4871.6 4872.9 4873.9 4881.1 2988.9 3144.8 3309.2 3329.6 3329.9 1061.8 1069.0 1077.7 1130.6 1144.5 10670.0 10722.0 10729.8 10745.7 10757.2 4168.5 4293.5 4366.0 4366.7 4369.1 9098.5 9130.5 9138.5 9144.7 9145.9 4828.5 4861.1 4879.9 4952.8 4974.3 4086.7 4392.5 4510.1 4547.3 4551.4 3668.5 3729.6 3788.0 3791.2 3811.3 1213.1 1222.3 1224.1 1227.5 1237.4 1030.2 1035.7 1042.7 1047.6 1071.2 5395.6 5493.1 5520.6 5556.5 5690.9 453.9 459.7 462.0 468.3 471.1 3982.5 4102.4 4117.5 4142.7 4187.4 9263.2 9342.2 9671.2 9754.1 9779.6 9550.0 9595.8 9619.7 9621.4 9659.4 7329.8 7404.6 7489.4 7534.3 7535.3 5563.4 5588.1 5696.4 5739.6 5817.4 8605.4 8788.1 8792.6 8881.2 8927.8 8617.8 8856.0 8901.3 8966.6 9212.1 6596.4 6833.3 6856.1 7022.6 7061.1 7503.4 7537.2 7598.2 7604.0 7613.0 6576.1 6744.7 6750.9 6861.6 6900.3 6810.5 6811.9 6847.8 6947.5 6984.6 6495.0 6581.4 6606.9 6676.7 6681.1 4725.2 4864.6 4890.0 4911.8 4977.8 4708.9 4821.9 4853.2 4882.3 4950.0 06:16:14 INFO - PROCESS | 3375 | 06:16:14 INFO - PROCESS | 3375 | [#4] prototype.html Cycles:180 Average:4581.42 Median:5288.28 stddev:1339.37 (25.3%) stddev-sans-first:1304.41 06:16:14 INFO - PROCESS | 3375 | Values: 321.4 329.6 332.5 333.9 334.0 5034.6 5111.6 5116.7 5138.4 5147.4 5038.8 5049.8 5060.0 5069.1 5075.6 3809.5 3858.5 3984.4 3984.6 3996.0 3989.4 3999.6 4004.3 4005.4 4014.4 3788.1 3940.1 3945.7 3951.4 3957.2 3849.2 3945.6 3960.9 3965.7 3987.6 3519.3 3521.8 3536.7 3545.9 3559.2 4839.0 4843.7 4851.7 4853.7 4865.8 4409.5 4554.6 4580.5 4581.8 4592.3 5278.6 5298.0 5314.7 5323.7 5324.5 3925.9 3930.2 3940.9 3956.2 3965.9 5388.7 5490.8 5563.5 5576.2 5587.1 3986.1 4006.2 4010.2 4015.2 4015.6 4072.5 4073.7 4074.3 4084.4 4106.9 4436.2 4592.8 4596.9 4606.5 4615.8 5364.5 5376.8 5384.0 5400.9 5418.9 1482.2 1490.8 1495.2 1497.2 1497.5 963.9 996.4 996.4 1011.9 1044.3 5396.2 5436.3 5481.2 5492.2 5494.8 5794.8 5822.6 5832.1 5842.3 5842.7 5311.4 5416.6 5492.3 5493.9 5495.3 3063.8 3083.7 3088.8 3090.8 3108.5 5464.7 5957.9 6025.3 6038.5 6042.3 5680.2 5693.9 5700.6 5702.5 5721.4 5725.3 5732.6 5741.3 5759.0 5777.7 5436.4 5519.1 5599.9 5609.7 5627.4 5533.9 5552.0 5560.7 5565.3 5567.5 5601.6 5761.7 5789.9 5799.9 5823.8 3947.5 3973.7 3985.3 3989.7 3992.1 5515.9 5527.3 5537.3 5541.2 5558.2 5268.8 5452.0 5453.9 5455.0 5466.6 5397.3 5402.2 5426.4 5427.1 5447.3 5067.2 5170.9 5320.0 5348.0 5365.8 5408.6 5416.2 5423.6 5427.3 5438.6 5303.5 5324.0 5326.7 5341.3 5351.0 06:16:14 INFO - PROCESS | 3375 | 06:16:14 INFO - PROCESS | 3375 | [#5] yui.html Cycles:180 Average:14899.63 Median:24731.45 stddev:17121.20 (69.2%) stddev-sans-first:17136.20 06:16:14 INFO - PROCESS | 3375 | Values: 737.5 800.2 830.5 851.8 890.1 14189.9 14234.7 14547.3 14571.1 14597.0 14153.2 14292.1 14310.6 14310.6 14313.7 682.3 705.6 709.4 710.6 819.6 835.7 847.9 848.8 849.9 849.9 871.0 881.5 881.9 882.4 882.6 716.9 850.4 862.8 872.8 893.5 641.2 644.1 647.6 647.9 648.6 13394.9 13439.5 13453.1 13463.4 13474.4 13615.8 14080.6 14154.9 14192.9 14275.2 11704.8 11867.3 11937.5 11984.8 12224.4 3841.2 3880.7 3959.9 3997.3 4048.2 54832.0 55567.7 57466.7 57796.0 57932.4 10671.8 10759.2 10973.0 10979.6 11308.3 18762.5 19363.7 20942.0 21011.9 21025.4 8617.2 8800.3 8850.4 8852.7 8906.1 4936.9 4941.0 4950.9 5055.2 5069.2 3394.8 3453.3 3485.1 3489.1 3496.9 580.4 651.9 658.3 659.2 659.3 534.9 662.3 684.8 756.2 781.5 8959.0 9295.4 9340.9 9341.3 9446.9 682.4 724.6 764.3 778.8 785.3 4312.3 4375.9 4477.7 4512.6 4564.9 55000.4 56934.7 57128.7 61993.1 62116.7 53209.0 54487.5 56519.4 57006.1 58337.0 50195.2 51218.0 52152.2 52679.5 53054.0 8494.3 8802.3 8947.5 9059.3 9182.5 33226.2 34305.0 34319.5 34604.5 35414.6 44604.0 44787.0 44848.0 44950.3 45688.3 11849.3 12023.2 12034.3 12218.2 12270.5 13009.5 13040.2 13251.3 13298.6 13299.8 11374.6 11498.1 11911.2 12075.7 12200.8 12275.6 12293.8 12344.6 12641.4 12737.4 12526.6 12778.5 12931.1 12945.5 13342.5 9766.0 10242.9 11337.1 11535.8 11581.7 10392.4 10398.4 10487.9 10862.2 10902.8 06:16:14 INFO - PROCESS | 3375 | -------- Summary: end -------- 06:16:14 INFO - PROCESS | 3375 | 06:16:14 INFO - TEST-INFO | 3375: exit 0 06:16:14 INFO - TEST-OK | dromaeo_css | took 1114323ms 06:16:14 INFO - TEST-START | kraken 06:16:14 INFO - operating with platform_type : linux_ 06:16:14 INFO - Initialising browser for kraken test... 06:16:14 INFO - TEST-INFO | started process 3553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpggYpbt/profile http://localhost:55510/getInfo.html) 06:16:19 INFO - PROCESS | 3553 | __metrics Screen width/height:1600/1200 06:16:19 INFO - PROCESS | 3553 | colorDepth:24 06:16:19 INFO - PROCESS | 3553 | Browser inner width/height: 1024/697 06:16:19 INFO - PROCESS | 3553 | __metrics 06:16:20 ERROR - PROCESS | 3553 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:16:21 INFO - TEST-INFO | 3553: exit 0 06:16:21 INFO - Browser initialized. 06:16:21 INFO - Running cycle 1/1 for kraken test... 06:16:21 INFO - TEST-INFO | started process 3635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpggYpbt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:32 INFO - PROCESS | 3635 | RSS: Main: 154681344 06:16:32 INFO - PROCESS | 3635 | 06:16:35 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55510/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:36 INFO - PROCESS | 3635 | RSS: Main: 209358848 06:16:36 INFO - PROCESS | 3635 | 06:16:39 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55510/tests/kraken/driver.html?testName=audio-dft) 06:16:39 INFO - PROCESS | 3635 | RSS: Main: 196988928 06:16:39 INFO - PROCESS | 3635 | 06:16:42 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55510/tests/kraken/driver.html?testName=audio-fft) 06:16:43 INFO - PROCESS | 3635 | RSS: Main: 266420224 06:16:43 INFO - PROCESS | 3635 | 06:16:45 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55510/tests/kraken/driver.html?testName=audio-oscillator) 06:16:45 INFO - PROCESS | 3635 | RSS: Main: 174059520 06:16:45 INFO - PROCESS | 3635 | 06:16:48 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55510/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:48 INFO - PROCESS | 3635 | RSS: Main: 178851840 06:16:48 INFO - PROCESS | 3635 | 06:16:51 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55510/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:52 INFO - PROCESS | 3635 | RSS: Main: 214999040 06:16:52 INFO - PROCESS | 3635 | 06:16:55 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55510/tests/kraken/driver.html?testName=imaging-desaturate) 06:16:56 INFO - PROCESS | 3635 | RSS: Main: 215072768 06:16:56 INFO - PROCESS | 3635 | 06:16:59 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55510/tests/kraken/driver.html?testName=json-parse-financial) 06:16:59 INFO - PROCESS | 3635 | RSS: Main: 215334912 06:16:59 INFO - PROCESS | 3635 | 06:17:01 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55510/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:17:01 INFO - PROCESS | 3635 | RSS: Main: 201785344 06:17:01 INFO - PROCESS | 3635 | 06:17:03 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55510/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:17:04 INFO - PROCESS | 3635 | RSS: Main: 203177984 06:17:04 INFO - PROCESS | 3635 | 06:17:06 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55510/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:17:07 INFO - PROCESS | 3635 | RSS: Main: 216403968 06:17:07 INFO - PROCESS | 3635 | 06:17:10 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:17:10 INFO - PROCESS | 3635 | RSS: Main: 223531008 06:17:10 INFO - PROCESS | 3635 | 06:17:13 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:14 INFO - PROCESS | 3635 | RSS: Main: 220033024 06:17:14 INFO - PROCESS | 3635 | 06:17:15 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:55510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55510/tests/kraken/driver.html?testName=ai-astar) 06:17:16 INFO - PROCESS | 3635 | RSS: Main: 282525696 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | __start_tp_report 06:17:16 INFO - PROCESS | 3635 | _x_x_mozilla_page_load 06:17:16 INFO - PROCESS | 3635 | _x_x_mozilla_page_load_details 06:17:16 INFO - PROCESS | 3635 | |i|pagename|runs| 06:17:16 INFO - PROCESS | 3635 | |0;ai-astar;110;112;105;111;112;111;100;112;111;109 06:17:16 INFO - PROCESS | 3635 | |1;audio-beat-detection;155;135;155;197;129;162;161;129;191;129 06:17:16 INFO - PROCESS | 3635 | |2;audio-dft;160;161;160;160;160;159;160;161;160;161 06:17:16 INFO - PROCESS | 3635 | |3;audio-fft;76;76;103;110;77;77;77;115;107;76 06:17:16 INFO - PROCESS | 3635 | |4;audio-oscillator;92;93;152;92;92;92;143;91;91;150 06:17:16 INFO - PROCESS | 3635 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;117 06:17:16 INFO - PROCESS | 3635 | |6;imaging-darkroom;145;145;146;145;146;145;145;146;145;145 06:17:16 INFO - PROCESS | 3635 | |7;imaging-desaturate;95;95;95;94;95;95;96;95;95;95 06:17:16 INFO - PROCESS | 3635 | |8;json-parse-financial;57;59;57;56;56;58;56;78;55;55 06:17:16 INFO - PROCESS | 3635 | |9;json-stringify-tinderbox;59;59;60;58;59;60;59;59;59;59 06:17:16 INFO - PROCESS | 3635 | |10;stanford-crypto-aes;78;84;77;75;92;76;77;77;77;77 06:17:16 INFO - PROCESS | 3635 | |11;stanford-crypto-ccm;125;120;121;142;120;119;121;123;159;133 06:17:16 INFO - PROCESS | 3635 | |12;stanford-crypto-pbkdf2;169;171;165;168;171;173;169;169;176;168 06:17:16 INFO - PROCESS | 3635 | |13;stanford-crypto-sha256-iterative;68;72;70;71;69;69;68;71;69;68 06:17:16 INFO - PROCESS | 3635 | __end_tp_report 06:17:16 INFO - PROCESS | 3635 | __start_cc_report 06:17:16 INFO - PROCESS | 3635 | _x_x_mozilla_cycle_collect,1624 06:17:16 INFO - PROCESS | 3635 | __end_cc_report 06:17:16 INFO - PROCESS | 3635 | __startTimestamp1462454236083__endTimestamp 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | ------- Summary: start ------- 06:17:16 INFO - PROCESS | 3635 | Number of tests: 14 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:4.12 06:17:16 INFO - PROCESS | 3635 | Values: 110.0 112.0 105.0 111.0 112.0 111.0 100.0 112.0 111.0 109.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:158.00 stddev:24.87 (15.7%) stddev-sans-first:26.38 06:17:16 INFO - PROCESS | 3635 | Values: 155.0 135.0 155.0 197.0 129.0 162.0 161.0 129.0 191.0 129.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:17:16 INFO - PROCESS | 3635 | Values: 160.0 161.0 160.0 160.0 160.0 159.0 160.0 161.0 160.0 161.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#3] audio-fft Cycles:10 Average:89.40 Median:76.00 stddev:16.91 (22.3%) stddev-sans-first:17.23 06:17:16 INFO - PROCESS | 3635 | Values: 76.0 76.0 103.0 110.0 77.0 77.0 77.0 115.0 107.0 76.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:92.00 stddev:27.38 (29.8%) stddev-sans-first:28.35 06:17:16 INFO - PROCESS | 3635 | Values: 92.0 93.0 152.0 92.0 92.0 92.0 143.0 91.0 91.0 150.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:17:16 INFO - PROCESS | 3635 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:17:16 INFO - PROCESS | 3635 | Values: 145.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 06:17:16 INFO - PROCESS | 3635 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 95.0 95.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:57.00 stddev:6.90 (12.1%) stddev-sans-first:7.29 06:17:16 INFO - PROCESS | 3635 | Values: 57.0 59.0 57.0 56.0 56.0 58.0 56.0 78.0 55.0 55.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 06:17:16 INFO - PROCESS | 3635 | Values: 59.0 59.0 60.0 58.0 59.0 60.0 59.0 59.0 59.0 59.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:77.00 stddev:5.16 (6.7%) stddev-sans-first:5.46 06:17:16 INFO - PROCESS | 3635 | Values: 78.0 84.0 77.0 75.0 92.0 76.0 77.0 77.0 77.0 77.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:124.00 stddev:13.00 (10.5%) stddev-sans-first:13.74 06:17:16 INFO - PROCESS | 3635 | Values: 125.0 120.0 121.0 142.0 120.0 119.0 121.0 123.0 159.0 133.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:170.00 stddev:3.03 (1.8%) stddev-sans-first:3.20 06:17:16 INFO - PROCESS | 3635 | Values: 169.0 171.0 165.0 168.0 171.0 173.0 169.0 169.0 176.0 168.0 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - PROCESS | 3635 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.43 (2.1%) stddev-sans-first:1.41 06:17:16 INFO - PROCESS | 3635 | Values: 68.0 72.0 70.0 71.0 69.0 69.0 68.0 71.0 69.0 68.0 06:17:16 INFO - PROCESS | 3635 | -------- Summary: end -------- 06:17:16 INFO - PROCESS | 3635 | 06:17:16 INFO - TEST-INFO | 3635: exit 0 06:17:17 INFO - TEST-OK | kraken | took 62202ms 06:17:17 INFO - SUITE-END | took 1176s 06:17:17 INFO - Completed test suite (00:19:36) 06:17:17 INFO - javascript benchmark 06:17:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.7851150419474, 3122.687731226876, 3131.655517893031, 3149.3228955774503, 3183.474726670099, 5175.223716442535, 5263.0263401270795, 5267.63126581139, 5305.310309659743, 5352.384475785281, 5206.5834733221345, 5258.605604579662, 5265.210218467222, 5306.814261500848, 5313.043652142613, 4728.40894888139, 4731.739754313511, 4742.881427964311, 4757.0723708876785, 4915.164422048242, 4824.300476430915, 4880.0, 4889.217725163974, 4890.364252647151, 4909.7545122743895, 4669.229577119771, 4673.042026384583, 4770.7376094314795, 4794.9280760788615, 4834.661573689843, 4720.079584481027, 4737.905241895177, 4739.123262196505, 4745.620350371962, 4781.330613714083, 4732.0, 4733.148033353995, 4738.312944623045, 4740.762961851928, 4757.524247575249, 5049.166887463564, 5100.566451851597, 5131.846044618667, 5230.08473517133, 5230.660007099526, 5607.383187849333, 5610.382857885629, 5625.184348269478, 5639.6334238274385, 5641.633293835928, 5682.289713785777, 5700.37295897451, 5705.372409035002, 5705.4579814917515, 5708.0, 5186.299849520305, 5295.576353891718, 5354.036273470812, 5401.567874570025, 5403.4866687665, 5787.276590426197, 5791.189233507228, 5795.855103622359, 5796.652200867961, 5838.095095260242, 5255.658382205144, 5514.972425137848, 5519.558435325244, 5521.00621888064, 5524.751386187631, 5466.945330546723, 5543.833684989457, 5567.972160139173, 5595.804146854922, 5610.4670056344585, 5563.860903477364, 5576.275084239104, 5587.55299576041, 5590.860228494239, 5592.077307244341, 5483.040467918098, 5609.411011843697, 5609.971950140223, 5630.5495560355075, 5637.605367624227, 4309.719868208619, 4309.978450107792, 4319.136172765459, 4322.394864718942, 4355.825766969349, 3786.4888240087785, 3794.051487128218, 3801.2967600993907, 3829.3872980323013, 3848.9615103849164, 5154.690718556899, 5248.947510524922, 5324.733763311819, 5332.2801421808335, 5340.839774806762, 5624.072028115315, 5646.463585959327, 5659.858503537444, 5682.176084467729, 5701.230333904953, 5283.260343551906, 5304.681719096867, 5306.0, 5323.574114070865, 5334.039872822852, 4660.207764680013, 4711.95288047122, 4717.363155973968, 4779.115863565252, 4804.303376010529, 5763.337216220105, 5766.192733017381, 5766.221560089334, 5807.709614519257, 5839.737211825478, 5573.609847310811, 5580.748866301107, 5582.106862901916, 5589.273394458694, 5596.496315331639, 5758.798442054508, 5771.163181338598, 5798.072308430631, 5883.911741323798, 5897.882042359214, 5603.719814009365, 5604.103343465026, 5608.4111168326735, 5608.663480191201, 5616.241807356118, 5680.77276908919, 5705.771769129188, 5713.143028545752, 5721.256236689203, 5721.570882183936, 5429.131338985743, 5569.08110161835, 5612.102063669793, 5647.0, 5660.0, 5548.056830338933, 5570.5265052470995, 5570.972145139411, 5571.4428557143965, 5583.274174357308, 5287.841364759063, 5442.319710036246, 5486.149646804752, 5504.6421982571, 5559.8888022240135, 5501.174823776466, 5550.084236100998, 5560.91658625129, 5580.972095139498, 5604.187392828098, 5478.658308149522, 5516.14499752539, 5519.144532597454, 5524.254225679642, 5550.08423610116], "value": 5193.375473849277, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.1992169748663, 651.6285717141228, 657.0308794528069, 663.8274048747326, 674.1034424215792, 37972.96216302696, 39695.404568931415, 39802.80098599507, 39808.2038359233, 39944.20111597767, 45426.0, 46170.307445388346, 46201.53798462015, 46225.768871155684, 46238.53761462384, 8850.159234872694, 9126.406783559081, 9127.68053118141, 9134.132257435533, 9139.543022848831, 8978.416402933788, 9106.544672766368, 9118.270538356915, 9121.224695900857, 9125.589348479334, 9131.178193962542, 9156.0, 9166.587503562356, 9208.401453905508, 9215.262778977665, 9047.864282035775, 9135.725928222164, 9142.908570914273, 9155.725328240096, 9157.908420915806, 8951.865722014176, 9075.0, 9077.228435582983, 9081.682141125095, 9087.227585655228, 42125.0, 42494.0, 42702.35946460805, 42764.358534622006, 42767.144657106684, 3540.8583656653705, 3979.303621866162, 3980.2835489611857, 4216.536181020086, 4541.545845415465, 33002.83498582516, 33316.50025249599, 33513.86935575572, 33548.0, 33592.32815343704, 4125.133721918371, 4224.134052519257, 4225.3873188387815, 4257.701960862741, 4285.442892423996, 319597.0, 321253.0, 321544.0, 321713.0, 322386.9999999977, 47682.761586192544, 52995.47004529982, 54436.0, 61384.0, 61971.38028619656, 56571.717141414854, 56804.71597641985, 56867.715661422255, 56906.71546642323, 57011.429885701444, 16633.417830375878, 16908.830911690973, 16935.0685712287, 16941.745873811902, 16946.152692365333, 11733.765324693459, 11960.461779219955, 12401.317927514074, 12677.239365638092, 12816.935915320364, 17473.56316092108, 17739.911300443673, 17956.0, 18063.458096257134, 18088.457346279632, 6527.477801775942, 6561.573497722633, 6698.363655452724, 6743.966280168666, 6796.558223715443, 1034.8085604163255, 1052.1057101463696, 1136.91992607022, 1141.9143564232716, 1225.1424003197797, 32357.51463728046, 32947.3410531788, 33249.0, 33554.66445335515, 33633.663663363055, 1190.922590031645, 1203.0435803536209, 1209.1717173735842, 1219.0613227814533, 1232.9260244385366, 17568.0, 17683.646327073642, 17756.644867102586, 17848.286068557372, 17901.0, 292328.0, 300477.0, 301421.0, 301869.0, 450438.0, 52742.73628631832, 52744.73627631837, 53124.46875531195, 53380.73309633427, 53415.19877201845, 1388.1393536007538, 1458.3145921416917, 1465.4284828916732, 1467.3690313165228, 1478.0835881753383, 30878.84560577183, 32899.0, 33053.37252784564, 33186.17034574155, 33765.32469350648, 50482.0, 50993.23510147425, 51001.0, 51013.48986510236, 51053.489465104874, 242941.0, 344403.0, 350785.0, 351245.0, 351967.0, 26331.736682632927, 26595.468090638467, 26824.06115786016, 27008.459830803666, 27259.0, 41899.7905010473, 42721.14557708891, 42886.356704650076, 43385.78307108444, 43816.342754858066, 39437.80281098576, 39584.60415395809, 40417.1916561673, 40808.183836323704, 40871.59128408797, 38440.80779596196, 39326.0, 39681.40477892776, 39988.800895928835, 40849.1830163401, 40324.59675403326, 40623.59376406198, 40734.796326019365, 41514.58485415107, 41519.0, 34080.48879266863, 35182.0, 35873.46189807207, 36243.63756362403, 36570.45144322784, 27861.16416507508, 28065.579016314365, 28130.71869281281, 28195.47370313461, 28263.43473130567], "value": 19677.146567968008, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.90986073203146, 393.66735108833046, 396.9523657161141, 398.22743876878855, 414.34326592351124, 14152.0, 17806.910965445153, 18177.63644727105, 18701.719474207897, 18764.437066887996, 16300.26648800804, 16530.256138473767, 16535.586610334747, 17512.036837973905, 17666.823331766678, 5597.160425936101, 5614.9157762633495, 5759.5968282220265, 5774.3936886626925, 5800.245968024151, 4083.183363327332, 5710.2862142232225, 5728.885422291552, 5762.164486149527, 6038.27540695115, 6227.470664993459, 6253.1870856788555, 6254.593451425642, 6271.435570798627, 6283.277423096357, 6192.876142477147, 6232.3144454110015, 6238.5944913580925, 6249.656268905208, 6270.278917924452, 5420.13277875538, 5528.087865502187, 5536.197251398565, 5538.972305138489, 5550.417206193332, 20624.484387890272, 21709.67435488469, 22254.777452225433, 22292.55414891693, 22337.32988010362, 2421.225207933462, 2506.448581312127, 2627.2906315294763, 2815.4650616382824, 3165.082126183404, 13879.722405551833, 13902.0, 13918.234497102656, 14161.929190354085, 14292.356843941943, 1914.4352416037163, 1932.232007712941, 1990.9303174388972, 2022.1203776357186, 2080.78151794061, 76701.0, 76707.0, 77712.0, 78199.0, 78972.60513697394, 10179.796404071878, 10299.691009269734, 10542.736431589272, 10603.787924241473, 10791.082757965503, 13215.537456188988, 13619.659508512366, 14824.851751482347, 14843.851561484247, 14845.480408185662, 7647.808804779814, 7663.233676632403, 7726.536407815549, 7885.842283154305, 7952.681892724342, 7432.0, 7708.113566939874, 7717.729879454192, 7795.922040779633, 7860.567668778158, 6441.0, 6553.934460655428, 6660.766873159416, 6683.565568238049, 6739.865202695919, 1798.7301904714398, 1886.4340697790883, 1908.780490243612, 1916.0, 1942.854285928561, 1041.5261056219401, 1066.173715370594, 1074.5272080284649, 1075.473018221066, 1143.9656810295705, 18108.185131669106, 18778.906105469658, 19156.137973791214, 19175.61648767017, 19315.80684193168, 1079.9244052916379, 1106.8284415915546, 1119.2333251722596, 1139.458757090392, 1161.8663853656938, 10710.303830251165, 11029.779404412027, 11056.778864422666, 11088.501017454233, 11117.332960022424, 452331.0, 455525.0, 504706.0, 509687.160949365, 516715.0, 80023.59988200021, 82623.0, 87107.0, 92597.0, 97821.51089244508, 1066.8506409102731, 1108.9001989820954, 1110.7889500994786, 1117.234694234452, 1123.0, 16554.83445165533, 16816.663666726352, 16857.578560536083, 16867.0, 17421.912890435466, 35113.648863511036, 39439.2112157761, 40459.59540404676, 41385.58614413817, 41389.793051034554, 43497.13005739804, 47899.52100478951, 48274.0, 48986.26520602123, 49114.0, 8596.613152408281, 8675.175858293453, 8701.884313315484, 8822.602982865657, 8891.955540222258, 8562.91437085646, 9495.796235212476, 11642.0, 13378.732425351633, 13454.596362109152, 11597.536098555964, 11976.940115299367, 12178.939105304416, 12196.085293603193, 12400.62798116058, 11564.0, 11670.649880503599, 11749.29504229749, 11779.116566257393, 11899.46452409661, 6490.740370385131, 9999.3000489965, 12056.75886482248, 12135.301057851731, 12221.633350999484, 8684.692373726768, 8718.433301835614, 8744.825103497767, 8828.690995815115, 8888.466691998501, 9125.908740912506, 11627.883721163018, 12187.573434929735, 12305.753884922431, 12310.322932238812], "value": 9269.388292216458, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.4849431463201, 1505.691333276678, 1524.0322395278997, 1642.4744081893798, 1758.947231583053, 7450.925490745091, 7710.807229819244, 7723.150453450123, 7723.884141737872, 7724.922750772491, 7550.395968322535, 7714.498557593753, 7733.497322674022, 7734.265244801749, 7735.1491335953, 1984.5038740314922, 2047.6109539187507, 2050.077465140685, 2273.056681477185, 2302.9193978210765, 2234.486068204314, 2304.665823455606, 2305.8962346694357, 2308.6998690170253, 2309.1225334372916, 2244.9438764030865, 2261.1407665087327, 2271.954560908781, 2273.624851899435, 2282.1784157703214, 1988.7215789789295, 2175.216921908112, 2224.71078759761, 2230.408941630461, 2230.553889222154, 2282.08716513396, 2300.861948283108, 2302.769723027684, 2305.0549274797254, 2306.4579823741406, 7681.57751323677, 7731.613419329067, 7744.7289344873225, 7745.690172393098, 7746.651400686983, 4693.530646935314, 4871.610271178297, 4872.902541949176, 4873.853784386474, 4881.1213981483315, 2988.8505574721394, 3144.795588286754, 3309.172706823294, 3329.6170940341685, 3329.916752081193, 1061.7557961668783, 1068.9625863094755, 1077.6605369308643, 1130.5867665418227, 1144.4506636814292, 10670.0, 10722.0, 10729.78540429187, 10745.731356716067, 10757.246992710514, 4168.541460439349, 4293.506246781598, 4366.0, 4366.672499562545, 4369.148016136823, 9098.454092754457, 9130.452172869649, 9138.497382644018, 9144.679936202201, 9145.908540914506, 4828.517148285144, 4861.149298872683, 4879.926801097987, 4952.801887924515, 4974.32846565709, 4086.6526345260986, 4392.472903251566, 4510.075434535912, 4547.295169248771, 4551.385562949025, 3668.5414323209598, 3729.589745128034, 3787.981060094682, 3791.2227993261317, 3811.2949104415216, 1213.0659392267905, 1222.2788554752738, 1224.1247508031622, 1227.5089964014287, 1237.3503910446907, 1030.1707125763833, 1035.699647102332, 1042.723678225271, 1047.5652604169184, 1071.1912506057877, 5395.568354531628, 5493.066178749622, 5520.558355331564, 5556.472135147154, 5690.943090569124, 453.866109497699, 459.73105733146485, 461.9792109355087, 468.28820193305984, 471.10725175791686, 3982.5021872265966, 4102.364133559303, 4117.526484454326, 4142.668586513072, 4187.43469631602, 9263.16631503168, 9342.205912497513, 9671.17794987434, 9754.122129008281, 9779.559919803625, 9550.044995500533, 9595.760105997266, 9619.663311784054, 9621.374610650286, 9659.372140810965, 7329.780106596811, 7404.555726656418, 7489.438292128003, 7534.284242996907, 7535.284148005931, 5563.360213575329, 5588.105903055492, 5696.430356964271, 5739.598228123991, 5817.389174136655, 8605.397622166389, 8788.07725188846, 8792.604332805167, 8881.156290152425, 8927.776805579913, 8617.784555386166, 8855.955720221358, 8901.33240006989, 8966.551672416223, 9212.124848139416, 6596.439302659328, 6833.3166683331265, 6856.108705868205, 7022.613756243456, 7061.082059332254, 7503.399728021855, 7537.170911199873, 7598.240175982358, 7604.049493813273, 7612.961935190288, 6576.145101136822, 6744.69648865812, 6750.898736518858, 6861.55399899005, 6900.309969003059, 6810.489213309121, 6811.89782153278, 6847.760328388483, 6947.513674042769, 6984.615846128511, 6495.0, 6581.3747693969, 6606.900896486461, 6676.732930682719, 6681.098051763144, 4725.2203386442225, 4864.586510146677, 4890.0, 4911.8280860169725, 4977.800887964441, 4708.905821883474, 4821.855344339676, 4853.223484242504, 4882.292067650242, 4950.034743225036], "value": 4232.213942348823, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.36851087612837, 329.5962446003645, 332.46473178183123, 333.88814747059735, 333.979961202328, 5034.647574669774, 5111.56551693106, 5116.669665886869, 5138.409082955462, 5147.433782283951, 5038.7984480620735, 5049.798008079672, 5060.0, 5069.062223488657, 5075.593952483801, 3809.476209516202, 3858.459815625815, 3984.3625019996807, 3984.581618930014, 3995.960040399588, 3989.4414781930554, 3999.6200360965663, 4004.299247631667, 4005.379166229239, 4014.3777714454304, 3788.1476667749675, 3940.113474468236, 3945.7435266707716, 3951.4467974483596, 3957.228340473609, 3849.2109117630816, 3945.5857135000842, 3960.861369852041, 3965.662918651918, 3987.5613682494904, 3519.348920449725, 3521.753477256593, 3536.6816986471085, 3545.929081418383, 3559.2169722660974, 4838.95161048392, 4843.733594652293, 4851.660383773137, 4853.660243782937, 4865.807877070105, 4409.5149533551285, 4554.567316104964, 4580.5190455002075, 4581.816727330903, 4592.288195329729, 5278.551323137538, 5298.0, 5314.73426328682, 5323.733813309319, 5324.535752668008, 3925.8625948091967, 3930.21395720857, 3940.9211815763524, 3956.188981258835, 3965.920681586381, 5388.7367305731295, 5490.80782172622, 5563.527100196488, 5576.219329293902, 5587.1339942309005, 3986.123052928351, 4006.2187873364996, 4010.1578668479365, 4015.217032678658, 4015.638592526687, 4072.490938632671, 4073.6741060715663, 4074.348104303297, 4084.4485994390375, 4106.938395924063, 4436.223660859337, 4592.816287348535, 4596.931046034312, 4606.470255920545, 4615.769211539409, 5364.463553644604, 5376.78492860289, 5384.0, 5400.9459905400445, 5418.938299860566, 1482.2366481262159, 1490.8360080391149, 1495.244901324824, 1497.1989985357782, 1497.4650982742558, 963.9325247232626, 996.4021587047713, 996.4121168510469, 1011.8768167334254, 1044.2637940252105, 5396.21754845553, 5436.293281873332, 5481.205225242317, 5492.187578099218, 5494.8076817312, 5794.768209271582, 5822.592418530747, 5832.096025116114, 5842.328132264844, 5842.707864606753, 5311.389190243094, 5416.593755468356, 5492.258545096441, 5493.945060549343, 5495.2856128703015, 3063.831489268067, 3083.722464978163, 3088.8301143437325, 3090.8454577271045, 3108.5026395776567, 5464.726763661801, 5957.910631340534, 6025.307089684655, 6038.486728628028, 6042.335343112254, 5680.233168522279, 5693.857653558612, 5700.60813815779, 5702.54379649627, 5721.370649228582, 5725.2843394575675, 5732.598718089694, 5741.339745929272, 5758.971205143947, 5777.653340799566, 5436.429174936733, 5519.095594545462, 5599.860003499945, 5609.719514024364, 5627.409122042291, 5533.916991245215, 5551.972885016285, 5560.749766260447, 5565.276514053147, 5567.5246059795, 5601.60788744784, 5761.695321871285, 5789.942100579109, 5799.884002320015, 5823.82528524145, 3947.480220115334, 3973.6821054316165, 3985.282649123186, 3989.7207195496035, 3992.1416895367634, 5515.862103447446, 5527.281453411031, 5537.307836520435, 5541.174001259306, 5558.221848941233, 5268.81559145428, 5451.972740136274, 5453.890922181614, 5454.9727251365075, 5466.562674985912, 5397.271368365377, 5402.243685883901, 5426.430224826337, 5427.050266203478, 5447.264619276347, 5067.163917953497, 5170.948290517047, 5319.973400132974, 5347.973260133675, 5365.8000219909645, 5408.648437851527, 5416.241726158262, 5423.566114710892, 5427.290403522878, 5438.646487978269, 5303.549198318186, 5323.973380133075, 5326.707031113326, 5341.332333458317, 5350.983313170485], "value": 4165.727454000457, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.5206116024583, 800.1558355934488, 830.4767996162417, 851.795569063425, 890.1009979920283, 14189.929050354747, 14234.71530569388, 14547.345369458373, 14571.052881562704, 14597.0, 14153.15081095135, 14292.07101538402, 14310.570682879505, 14310.642233944156, 14313.71372572548, 682.2529330383222, 705.6436499567711, 709.38283693187, 710.6482291265805, 819.5574389829485, 835.7200337886816, 847.855864503036, 848.8302339532088, 849.8597731374316, 849.8810166576684, 870.9912900870974, 881.4579033894173, 881.8633111867671, 882.4220135811054, 882.6072397782989, 716.924722904098, 850.4344610833788, 862.8058686795483, 872.7992561710779, 893.5398269890946, 641.1952998986243, 644.1111266452313, 647.5596594315863, 647.8769033883547, 648.5946283572767, 13394.866051339459, 13439.462421503225, 13453.05828591999, 13463.394147263396, 13474.393652285671, 13615.795763063563, 14080.647983800385, 14154.92922535391, 14192.929035354757, 14275.21486318252, 11704.77609254239, 11867.287962722265, 11937.522499100025, 11984.760304793856, 12224.449899754443, 3841.2125514269787, 3880.708946828999, 3959.881203563869, 3997.34043882759, 4048.1701251243426, 54832.0, 55567.72216138934, 57466.71266643682, 57796.0, 57932.420675793124, 10671.786564268672, 10759.193060520493, 10973.0, 10979.560817567208, 11308.321500709984, 18762.530936726416, 19363.709544356847, 20942.0, 21011.894940525504, 21025.369238922856, 8617.209622947516, 8800.295976322006, 8850.424722393023, 8852.690155844643, 8906.109389061043, 4936.8765780855765, 4940.975295123501, 4950.925736113961, 5055.216441451581, 5069.188929771292, 3394.762366634312, 3453.309338132384, 3485.0938755923644, 3489.1451594359546, 3496.930061398758, 580.4021857486796, 651.947844172465, 658.285167139604, 659.2089492608889, 659.3011407907633, 534.8555889909702, 662.2814246542555, 684.8116767888771, 756.1946526948782, 781.4725060584196, 8959.0, 9295.395799273025, 9340.906590934139, 9341.34610577253, 9446.929747831982, 682.3994884501607, 724.5543990445838, 764.3388468974408, 778.8442311537715, 785.2540086917451, 4312.266914624522, 4375.912481750347, 4477.708948918375, 4512.571305725951, 4564.931526027112, 55000.449995500334, 56934.7153264231, 57128.71435642878, 61993.110654487755, 62116.689416553534, 53209.0, 54487.45512544903, 56519.43480565224, 57006.14490782641, 58337.0, 50195.24707129396, 51218.0, 52152.21771673428, 52679.47320526746, 53054.0, 8494.27798637098, 8802.339824513316, 8947.463152210888, 9059.320550958837, 9182.506291090891, 33226.169345766546, 34305.0, 34319.4852077214, 34604.480932785526, 35414.63560961704, 44604.0, 44787.0, 44848.0, 44950.325745114504, 45688.31467527923, 11849.348285844017, 12023.158378913393, 12034.277943323428, 12218.20581662189, 12270.509179632714, 13009.544665936646, 13040.152390094614, 13251.271180085188, 13298.601041968757, 13299.800502992657, 11374.601888933848, 11498.08015358786, 11911.225770324902, 12075.698107547381, 12200.755984880076, 12275.631731048083, 12293.75412491763, 12344.567940122053, 12641.3679316032, 12737.426815793126, 12526.561570344995, 12778.488860445477, 12931.094823362275, 12945.54690585825, 13342.533011344556, 9766.0, 10242.948785256027, 11337.093032557541, 11535.769284614093, 11581.710457238636, 10392.37645741258, 10398.376097434179, 10487.947560262455, 10862.185336099667, 10902.78194436091], "value": 6801.563820187436, "unit": "score"}], "name": "dromaeo_css", "value": 6959.261641381164, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 105.0, 111.0, 112.0, 111.0, 100.0, 112.0, 111.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 135.0, 155.0, 197.0, 129.0, 162.0, 161.0, 129.0, 191.0, 129.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 159.0, 160.0, 161.0, 160.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 103.0, 110.0, 77.0, 77.0, 77.0, 115.0, 107.0, 76.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 152.0, 92.0, 92.0, 92.0, 143.0, 91.0, 91.0, 150.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 57.0, 56.0, 56.0, 58.0, 56.0, 78.0, 55.0, 55.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 58.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 77.0, 75.0, 92.0, 76.0, 77.0, 77.0, 77.0, 77.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 120.0, 121.0, 142.0, 120.0, 119.0, 121.0, 123.0, 159.0, 133.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 165.0, 168.0, 171.0, 173.0, 169.0, 169.0, 176.0, 168.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 70.0, 71.0, 69.0, 69.0, 68.0, 71.0, 69.0, 68.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1543.6, "alertThreshold": 2.0}]} 06:17:17 INFO - Return code: 0 06:17:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:17:17 ERROR - # TBPL SUCCESS # 06:17:17 INFO - Running post-action listener: _resource_record_post_action 06:17:17 INFO - Running post-run listener: _resource_record_post_run 06:17:18 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7979008; Write bytes: 427601920; Read time: 1520; Write time: 347924 06:17:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 96407552; Read time: 84; Write time: 64328 06:17:18 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6238208; Write bytes: 331194368; Read time: 1384; Write time: 283596 06:17:18 INFO - Running post-run listener: _upload_blobber_files 06:17:18 INFO - Blob upload gear active. 06:17:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:17:18 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 06:17:18 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:17:18 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:17:18 INFO - (blobuploader) - INFO - Open directory for files ... 06:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:19 INFO - (blobuploader) - INFO - Done attempting. 06:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:17:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:20 INFO - (blobuploader) - INFO - Done attempting. 06:17:20 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:20 INFO - Return code: 0 06:17:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c16ad29c89b689dfb86a5ef1334119ee48d3ca4890a38c03f8faab436ac4415d4a9a7b08882bc1638cb88d302e0379b12b0d0c8c7421580cdb30d1f7153aa9e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8882c4d439d4936317235197d1a445beb54b4dccd5292b56ba4f39618fd75d2e151862af072f9b52edbec4033f19b1ca62aa71b86a7ed032b51a66153ebbe973"} 06:17:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:20 INFO - Contents: 06:17:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c16ad29c89b689dfb86a5ef1334119ee48d3ca4890a38c03f8faab436ac4415d4a9a7b08882bc1638cb88d302e0379b12b0d0c8c7421580cdb30d1f7153aa9e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8882c4d439d4936317235197d1a445beb54b4dccd5292b56ba4f39618fd75d2e151862af072f9b52edbec4033f19b1ca62aa71b86a7ed032b51a66153ebbe973"} 06:17:20 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:20 INFO - Copying logs to upload dir... 06:17:20 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.558153 ========= master_lag: -0.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-05 06:17:20.557372) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 06:17:20.560989) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c16ad29c89b689dfb86a5ef1334119ee48d3ca4890a38c03f8faab436ac4415d4a9a7b08882bc1638cb88d302e0379b12b0d0c8c7421580cdb30d1f7153aa9e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8882c4d439d4936317235197d1a445beb54b4dccd5292b56ba4f39618fd75d2e151862af072f9b52edbec4033f19b1ca62aa71b86a7ed032b51a66153ebbe973"} build_url:https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011093 build_url: 'https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c16ad29c89b689dfb86a5ef1334119ee48d3ca4890a38c03f8faab436ac4415d4a9a7b08882bc1638cb88d302e0379b12b0d0c8c7421580cdb30d1f7153aa9e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8882c4d439d4936317235197d1a445beb54b4dccd5292b56ba4f39618fd75d2e151862af072f9b52edbec4033f19b1ca62aa71b86a7ed032b51a66153ebbe973"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 06:17:20.586162) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 06:17:20.586522) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462452953.668377-951717228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 06:17:20.669405) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 06:17:20.669741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 06:17:20.670078) ========= ========= Total master_lag: -0.25 =========