builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1464786725.16 results: success (0) buildid: 20160601032755 builduid: 9179d18f9d0d4897b568a8e473386682 revision: 8b7e3ca6ddb7c3d7ad1dfd8b61ab18189e6ca1f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:05.161620) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:05.162164) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:05.162466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:05.192946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:05.193381) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 06:12:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.5M=0s 2016-06-01 06:12:05 (25.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089353 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:05.296712) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:05.297105) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021933 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:05.347476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:05.347839) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8b7e3ca6ddb7c3d7ad1dfd8b61ab18189e6ca1f3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8b7e3ca6ddb7c3d7ad1dfd8b61ab18189e6ca1f3 --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=a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 06:12:05,732 truncating revision to first 12 chars 2016-06-01 06:12:05,732 Setting DEBUG logging. 2016-06-01 06:12:05,732 attempt 1/10 2016-06-01 06:12:05,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8b7e3ca6ddb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 06:12:06,041 unpacking tar archive at: mozilla-aurora-8b7e3ca6ddb7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647727 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:06.009152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:06.009463) ========= script_repo_revision: 8b7e3ca6ddb7c3d7ad1dfd8b61ab18189e6ca1f3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:06.009863) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:06.010133) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 06:12:06.018934) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-01 06:12:06.019242) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:12:06 INFO - MultiFileLogger online at 20160601 06:12:06 in /builds/slave/test 06:12:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:12:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:12:06 INFO - {'append_to_log': False, 06:12:06 INFO - 'base_work_dir': '/builds/slave/test', 06:12:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:12:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:12:06 INFO - 'branch': 'Mozilla-Aurora', 06:12:06 INFO - 'buildbot_json_path': 'buildprops.json', 06:12:06 INFO - 'config_files': ('talos/linux_config.py',), 06:12:06 INFO - 'default_actions': ('clobber', 06:12:06 INFO - 'read-buildbot-config', 06:12:06 INFO - 'download-and-extract', 06:12:06 INFO - 'populate-webroot', 06:12:06 INFO - 'create-virtualenv', 06:12:06 INFO - 'install', 06:12:06 INFO - 'run-tests'), 06:12:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:12:06 INFO - 'download_minidump_stackwalk': True, 06:12:06 INFO - 'download_symbols': 'ondemand', 06:12:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:12:06 INFO - 'tooltool.py': '/tools/tooltool.py', 06:12:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:12:06 INFO - '/tools/misc-python/virtualenv.py')}, 06:12:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:12:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:12:06 INFO - 'installer_path': 'installer.exe', 06:12:06 INFO - 'log_level': 'info', 06:12:06 INFO - 'log_name': 'talos', 06:12:06 INFO - 'log_to_console': True, 06:12:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:12:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:12:06 INFO - 'opt_config_files': (), 06:12:06 INFO - 'pip_index': False, 06:12:06 INFO - 'sps_profile': False, 06:12:06 INFO - 'sps_profile_interval': 0, 06:12:06 INFO - 'suite': 'dromaeojs-e10s', 06:12:06 INFO - 'system_bits': '32', 06:12:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:12:06 INFO - 'title': 'talos-linux64-ix-064', 06:12:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:12:06 INFO - 'use_talos_json': True, 06:12:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:12:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:12:06 INFO - 'work_dir': 'build'} 06:12:06 INFO - ##### 06:12:06 INFO - ##### Running clobber step. 06:12:06 INFO - ##### 06:12:06 INFO - Running pre-action listener: _resource_record_pre_action 06:12:06 INFO - Running main action method: clobber 06:12:06 INFO - rmtree: /builds/slave/test/build 06:12:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:12:06 INFO - Running post-action listener: _resource_record_post_action 06:12:06 INFO - ##### 06:12:06 INFO - ##### Running read-buildbot-config step. 06:12:06 INFO - ##### 06:12:06 INFO - Running pre-action listener: _resource_record_pre_action 06:12:06 INFO - Running main action method: read_buildbot_config 06:12:06 INFO - Using buildbot properties: 06:12:06 INFO - { 06:12:06 INFO - "project": "", 06:12:06 INFO - "product": "firefox", 06:12:06 INFO - "script_repo_revision": "production", 06:12:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:12:06 INFO - "repository": "", 06:12:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:12:06 INFO - "buildid": "20160601032755", 06:12:06 INFO - "pgo_build": "True", 06:12:06 INFO - "basedir": "/builds/slave/test", 06:12:06 INFO - "buildnumber": 323, 06:12:06 INFO - "slavename": "talos-linux64-ix-064", 06:12:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:12:06 INFO - "platform": "ubuntu64_hw", 06:12:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:12:06 INFO - "branch": "mozilla-aurora", 06:12:06 INFO - "repo_path": "releases/mozilla-aurora", 06:12:06 INFO - "revision": "8b7e3ca6ddb7c3d7ad1dfd8b61ab18189e6ca1f3", 06:12:06 INFO - "stage_platform": "linux64-pgo", 06:12:06 INFO - "builduid": "9179d18f9d0d4897b568a8e473386682", 06:12:06 INFO - "slavebuilddir": "test" 06:12:06 INFO - } 06:12:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 06:12:06 INFO - Running post-action listener: _resource_record_post_action 06:12:06 INFO - ##### 06:12:06 INFO - ##### Running download-and-extract step. 06:12:06 INFO - ##### 06:12:06 INFO - Running pre-action listener: _resource_record_pre_action 06:12:06 INFO - Running main action method: download_and_extract 06:12:06 INFO - mkdir: /builds/slave/test/build/tests 06:12: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')]} 06:12:06 INFO - https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:12:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:12:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:12:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:12:07 INFO - Downloaded 1361 bytes. 06:12:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:12:07 INFO - Using the following test package requirements: 06:12:07 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:12:07 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:12:07 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:12:07 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:12:07 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:12:07 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:12:07 INFO - u'jsshell-linux-x86_64.zip'], 06:12:07 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:12:07 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:12:07 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:12:07 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:12:07 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:12:07 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:12:07 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:12:07 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:12:07 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:12:07 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:12:07 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:12:07 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:07 INFO - https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:12:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:12:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:12:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:12:09 INFO - Downloaded 24174366 bytes. 06:12:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:12:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:12:10 INFO - Return code: 0 06:12:10 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:10 INFO - https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:12:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:12:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:12:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:12:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:12:11 INFO - Downloaded 24174366 bytes. 06:12:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:12:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:12:13 INFO - Return code: 0 06:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:13 INFO - https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:12:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:12:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:12:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:12:14 INFO - Downloaded 10840145 bytes. 06:12:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:12:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:12:14 INFO - Return code: 0 06:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:14 INFO - https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:12:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:12:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:12:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:12:15 INFO - Downloaded 62801770 bytes. 06:12:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:12:15 INFO - mkdir: /builds/slave/test/properties 06:12:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:12:15 INFO - Writing to file /builds/slave/test/properties/build_url 06:12:15 INFO - Contents: 06:12:15 INFO - build_url:https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:12:16 INFO - Running post-action listener: _resource_record_post_action 06:12:16 INFO - Running post-action listener: set_extra_try_arguments 06:12:16 INFO - ##### 06:12:16 INFO - ##### Running populate-webroot step. 06:12:16 INFO - ##### 06:12:16 INFO - Running pre-action listener: _resource_record_pre_action 06:12:16 INFO - Running main action method: populate_webroot 06:12:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:12:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:12:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:12:16 INFO - '--tppagecycles', 06:12:16 INFO - '7'], 06:12:16 INFO - 'tests': ['tsvgm']}}, 06:12:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:12:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:12:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:12:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:12:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:12:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:12:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:16 INFO - 'talos_options': ['--disable-e10s'], 06:12:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:12:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:12:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:16 INFO - 'talos_options': ['--disable-e10s'], 06:12:16 INFO - 'tests': ['damp', 'tps']}, 06:12:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:16 INFO - 'tests': ['damp', 'tps']}, 06:12:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:12:16 INFO - 'tests': ['dromaeo_dom']}, 06:12:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:12:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:12:16 INFO - 'tests': ['a11yr', 06:12:16 INFO - 'ts_paint', 06:12:16 INFO - 'tpaint', 06:12:16 INFO - 'sessionrestore', 06:12:16 INFO - 'sessionrestore_no_auto_restore', 06:12:16 INFO - 'tabpaint']}, 06:12:16 INFO - 'other-e10s': {'tests': ['a11yr', 06:12:16 INFO - 'ts_paint', 06:12:16 INFO - 'tpaint', 06:12:16 INFO - 'sessionrestore', 06:12:16 INFO - 'sessionrestore_no_auto_restore', 06:12:16 INFO - 'tabpaint']}, 06:12:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:12:16 INFO - 'ts_paint', 06:12:16 INFO - 'tpaint', 06:12:16 INFO - 'sessionrestore', 06:12:16 INFO - 'sessionrestore_no_auto_restore', 06:12:16 INFO - 'tabpaint']}, 06:12:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:12:16 INFO - 'ts_paint', 06:12:16 INFO - 'tpaint', 06:12:16 INFO - 'sessionrestore', 06:12:16 INFO - 'sessionrestore_no_auto_restore', 06:12:16 INFO - 'tabpaint']}, 06:12:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:12:16 INFO - 'tests': ['a11yr', 06:12:16 INFO - 'ts_paint', 06:12:16 INFO - 'tpaint', 06:12:16 INFO - 'sessionrestore', 06:12:16 INFO - 'sessionrestore_no_auto_restore', 06:12:16 INFO - 'tabpaint']}, 06:12:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:12:16 INFO - 'tests': ['a11yr', 06:12:16 INFO - 'ts_paint', 06:12:16 INFO - 'tpaint', 06:12:16 INFO - 'sessionrestore', 06:12:16 INFO - 'sessionrestore_no_auto_restore', 06:12:16 INFO - 'tabpaint']}, 06:12:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:12:16 INFO - 'tests': ['tsvgx', 06:12:16 INFO - 'tsvgr_opacity', 06:12:16 INFO - 'tart', 06:12:16 INFO - 'tscrollx', 06:12:16 INFO - 'cart']}, 06:12:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:12:16 INFO - 'tsvgr_opacity', 06:12:16 INFO - 'tart', 06:12:16 INFO - 'tscrollx', 06:12:16 INFO - 'cart']}, 06:12:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:16 INFO - 'talos_options': ['--disable-e10s'], 06:12:16 INFO - 'tests': ['tp5o']}, 06:12:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:16 INFO - 'tests': ['tp5o']}, 06:12:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:16 INFO - 'talos_options': ['--disable-e10s', 06:12:16 INFO - '--xperf_path', 06:12:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:12:16 INFO - 'tests': ['tp5n']}, 06:12:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:16 INFO - 'talos_options': ['--xperf_path', 06:12:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:12:16 INFO - 'tests': ['tp5n']}}, 06:12:16 INFO - 'talos.zip': {'path': '', 06:12:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:12:16 INFO - Running post-action listener: _resource_record_post_action 06:12:16 INFO - ##### 06:12:16 INFO - ##### Running create-virtualenv step. 06:12:16 INFO - ##### 06:12:16 INFO - Running pre-action listener: _resource_record_pre_action 06:12:16 INFO - Running main action method: create_virtualenv 06:12:16 INFO - Creating virtualenv /builds/slave/test/build/venv 06:12:16 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 06:12:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:12:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:12:16 INFO - Using real prefix '/usr' 06:12:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:12:17 INFO - Installing distribute.............................................................................................................................................................................................done. 06:12:19 INFO - Installing pip.................done. 06:12:19 INFO - Return code: 0 06:12:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:12: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')]} 06:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12: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')]} 06:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d0ca0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e410>, '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 0x173f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173f7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', '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 06:12: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', 'pip>=1.5'] in /builds/slave/test/build 06:12: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 pip>=1.5 06:12:19 INFO - Using env: {'DISPLAY': ':0', 06:12:19 INFO - 'HOME': '/home/cltbld', 06:12:19 INFO - 'LANG': 'en_US.UTF-8', 06:12:19 INFO - 'LANGUAGE': 'en_US:en', 06:12:19 INFO - 'LOGNAME': 'cltbld', 06:12:19 INFO - 'MAIL': '/var/mail/cltbld', 06:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:19 INFO - 'MOZ_NO_REMOTE': '1', 06:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:19 INFO - 'NO_EM_RESTART': '1', 06:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:19 INFO - 'PWD': '/builds/slave/test', 06:12:19 INFO - 'SHELL': '/bin/bash', 06:12:19 INFO - 'SHLVL': '1', 06:12:19 INFO - 'TERM': 'linux', 06:12:19 INFO - 'TMOUT': '86400', 06:12:19 INFO - 'USER': 'cltbld', 06:12:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', 06:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:19 INFO - '_': '/tools/buildbot/bin/python'} 06:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:19 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 06:12:19 INFO - Cleaning up... 06:12:19 INFO - Return code: 0 06:12:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:12: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')]} 06:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12: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')]} 06:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12: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', '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 0x7f9d0ca0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e410>, '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 0x173f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173f7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', '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 06:12: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:12: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 psutil>=0.7.1 06:12:19 INFO - Using env: {'DISPLAY': ':0', 06:12:19 INFO - 'HOME': '/home/cltbld', 06:12:19 INFO - 'LANG': 'en_US.UTF-8', 06:12:19 INFO - 'LANGUAGE': 'en_US:en', 06:12:19 INFO - 'LOGNAME': 'cltbld', 06:12:19 INFO - 'MAIL': '/var/mail/cltbld', 06:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:19 INFO - 'MOZ_NO_REMOTE': '1', 06:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:19 INFO - 'NO_EM_RESTART': '1', 06:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:19 INFO - 'PWD': '/builds/slave/test', 06:12:19 INFO - 'SHELL': '/bin/bash', 06:12:19 INFO - 'SHLVL': '1', 06:12:19 INFO - 'TERM': 'linux', 06:12:19 INFO - 'TMOUT': '86400', 06:12:19 INFO - 'USER': 'cltbld', 06:12:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', 06:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:19 INFO - '_': '/tools/buildbot/bin/python'} 06:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:19 INFO - Downloading/unpacking psutil>=0.7.1 06:12: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 06:12: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 06:12: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 06:12: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 06:12: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 06:12: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 06:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:12:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:12:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:12:21 INFO - Installing collected packages: psutil 06:12:21 INFO - Running setup.py install for psutil 06:12:21 INFO - building 'psutil._psutil_linux' extension 06:12:21 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 06:12:21 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 06:12:21 INFO - building 'psutil._psutil_posix' extension 06:12:21 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 06:12:22 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 06:12:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:12:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:12:22 INFO - Successfully installed psutil 06:12:22 INFO - Cleaning up... 06:12:22 INFO - Return code: 0 06:12:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:12:22 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')]} 06:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:22 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')]} 06:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:22 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 0x7f9d0ca0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e410>, '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 0x173f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173f7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', '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 06:12:22 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 06:12:22 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 06:12:22 INFO - Using env: {'DISPLAY': ':0', 06:12:22 INFO - 'HOME': '/home/cltbld', 06:12:22 INFO - 'LANG': 'en_US.UTF-8', 06:12:22 INFO - 'LANGUAGE': 'en_US:en', 06:12:22 INFO - 'LOGNAME': 'cltbld', 06:12:22 INFO - 'MAIL': '/var/mail/cltbld', 06:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:22 INFO - 'MOZ_NO_REMOTE': '1', 06:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:22 INFO - 'NO_EM_RESTART': '1', 06:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:22 INFO - 'PWD': '/builds/slave/test', 06:12:22 INFO - 'SHELL': '/bin/bash', 06:12:22 INFO - 'SHLVL': '1', 06:12:22 INFO - 'TERM': 'linux', 06:12:22 INFO - 'TMOUT': '86400', 06:12:22 INFO - 'USER': 'cltbld', 06:12:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', 06:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:22 INFO - '_': '/tools/buildbot/bin/python'} 06:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:12:24 INFO - Installing collected packages: mozsystemmonitor 06:12:24 INFO - Running setup.py install for mozsystemmonitor 06:12:24 INFO - Successfully installed mozsystemmonitor 06:12:24 INFO - Cleaning up... 06:12:24 INFO - Return code: 0 06:12:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:24 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 0x7f9d0ca0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e410>, '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 0x173f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173f7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', '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 06:12:24 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 06:12:24 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 06:12:24 INFO - Using env: {'DISPLAY': ':0', 06:12:24 INFO - 'HOME': '/home/cltbld', 06:12:24 INFO - 'LANG': 'en_US.UTF-8', 06:12:24 INFO - 'LANGUAGE': 'en_US:en', 06:12:24 INFO - 'LOGNAME': 'cltbld', 06:12:24 INFO - 'MAIL': '/var/mail/cltbld', 06:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:24 INFO - 'MOZ_NO_REMOTE': '1', 06:12:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:24 INFO - 'NO_EM_RESTART': '1', 06:12:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:24 INFO - 'PWD': '/builds/slave/test', 06:12:24 INFO - 'SHELL': '/bin/bash', 06:12:24 INFO - 'SHLVL': '1', 06:12:24 INFO - 'TERM': 'linux', 06:12:24 INFO - 'TMOUT': '86400', 06:12:24 INFO - 'USER': 'cltbld', 06:12:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', 06:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:24 INFO - '_': '/tools/buildbot/bin/python'} 06:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:24 INFO - Downloading/unpacking blobuploader==1.2.4 06:12:24 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 06:12:24 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 06:12:24 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 06:12:24 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 06:12:24 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 06:12:24 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 06:12:25 INFO - Downloading blobuploader-1.2.4.tar.gz 06:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:12:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:12:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:12:26 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 06:12:26 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 06:12:26 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 06:12:26 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 06:12:26 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 06:12:26 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 06:12:26 INFO - Downloading docopt-0.6.1.tar.gz 06:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:12:26 INFO - Installing collected packages: blobuploader, requests, docopt 06:12:26 INFO - Running setup.py install for blobuploader 06:12:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:12:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:12:26 INFO - Running setup.py install for requests 06:12:27 INFO - Running setup.py install for docopt 06:12:27 INFO - Successfully installed blobuploader requests docopt 06:12:27 INFO - Cleaning up... 06:12:27 INFO - Return code: 0 06:12:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:27 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 0x7f9d0ca0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e410>, '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 0x173f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173f7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', '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 06:12:27 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 06:12:27 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 06:12:27 INFO - Using env: {'DISPLAY': ':0', 06:12:27 INFO - 'HOME': '/home/cltbld', 06:12:27 INFO - 'LANG': 'en_US.UTF-8', 06:12:27 INFO - 'LANGUAGE': 'en_US:en', 06:12:27 INFO - 'LOGNAME': 'cltbld', 06:12:27 INFO - 'MAIL': '/var/mail/cltbld', 06:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:27 INFO - 'MOZ_NO_REMOTE': '1', 06:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:27 INFO - 'NO_EM_RESTART': '1', 06:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:27 INFO - 'PWD': '/builds/slave/test', 06:12:27 INFO - 'SHELL': '/bin/bash', 06:12:27 INFO - 'SHLVL': '1', 06:12:27 INFO - 'TERM': 'linux', 06:12:27 INFO - 'TMOUT': '86400', 06:12:27 INFO - 'USER': 'cltbld', 06:12:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', 06:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:27 INFO - '_': '/tools/buildbot/bin/python'} 06:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:27 INFO - Running setup.py (path:/tmp/pip-JoBM3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:27 INFO - Running setup.py (path:/tmp/pip-qe8QOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:27 INFO - Running setup.py (path:/tmp/pip-Uw9T2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:27 INFO - Running setup.py (path:/tmp/pip-k5F7JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:27 INFO - Running setup.py (path:/tmp/pip-qMckKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:27 INFO - Running setup.py (path:/tmp/pip-NBSPun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:27 INFO - Running setup.py (path:/tmp/pip-_iOjTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:27 INFO - Running setup.py (path:/tmp/pip-OCk5ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:27 INFO - Running setup.py (path:/tmp/pip-1iYuP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:27 INFO - Running setup.py (path:/tmp/pip-H5A7NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:28 INFO - Running setup.py (path:/tmp/pip-lCqrTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:28 INFO - Running setup.py (path:/tmp/pip-ztPeX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:28 INFO - Running setup.py (path:/tmp/pip-qKdIk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:28 INFO - Running setup.py (path:/tmp/pip-5n3UIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:28 INFO - Running setup.py (path:/tmp/pip-NGAk4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:28 INFO - Running setup.py (path:/tmp/pip-IPGmyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:28 INFO - Running setup.py (path:/tmp/pip-dfKMTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:12:28 INFO - Running setup.py install for manifestparser 06:12:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:12:28 INFO - Running setup.py install for mozcrash 06:12:28 INFO - Running setup.py install for mozdebug 06:12:28 INFO - Running setup.py install for mozdevice 06:12:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:12:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:12:28 INFO - Running setup.py install for mozfile 06:12:29 INFO - Running setup.py install for mozhttpd 06:12:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:12:29 INFO - Running setup.py install for mozinfo 06:12:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:12:29 INFO - Running setup.py install for mozInstall 06:12:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:12:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:12:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:12:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:12:29 INFO - Running setup.py install for mozleak 06:12:29 INFO - Running setup.py install for mozlog 06:12:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:12:29 INFO - Running setup.py install for moznetwork 06:12:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:12:29 INFO - Running setup.py install for mozprocess 06:12:29 INFO - Running setup.py install for mozprofile 06:12:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:12:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:12:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:12:29 INFO - Running setup.py install for mozrunner 06:12:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:12:30 INFO - Running setup.py install for mozscreenshot 06:12:30 INFO - Running setup.py install for moztest 06:12:30 INFO - Running setup.py install for mozversion 06:12:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:12:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:12:30 INFO - Cleaning up... 06:12:30 INFO - Return code: 0 06:12:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:30 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 0x7f9d0ca0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e410>, '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 0x173f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173f7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', '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 06:12:30 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 06:12:30 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 06:12:30 INFO - Using env: {'DISPLAY': ':0', 06:12:30 INFO - 'HOME': '/home/cltbld', 06:12:30 INFO - 'LANG': 'en_US.UTF-8', 06:12:30 INFO - 'LANGUAGE': 'en_US:en', 06:12:30 INFO - 'LOGNAME': 'cltbld', 06:12:30 INFO - 'MAIL': '/var/mail/cltbld', 06:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:30 INFO - 'MOZ_NO_REMOTE': '1', 06:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:30 INFO - 'NO_EM_RESTART': '1', 06:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:30 INFO - 'PWD': '/builds/slave/test', 06:12:30 INFO - 'SHELL': '/bin/bash', 06:12:30 INFO - 'SHLVL': '1', 06:12:30 INFO - 'TERM': 'linux', 06:12:30 INFO - 'TMOUT': '86400', 06:12:30 INFO - 'USER': 'cltbld', 06:12:30 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', 06:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:30 INFO - '_': '/tools/buildbot/bin/python'} 06:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:30 INFO - Running setup.py (path:/tmp/pip-RnJjH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:30 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)) 06:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:30 INFO - Running setup.py (path:/tmp/pip-EAbh0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:30 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)) 06:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:30 INFO - Running setup.py (path:/tmp/pip-y20hwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:30 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)) 06:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:30 INFO - Running setup.py (path:/tmp/pip-8yCkmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:30 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)) 06:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:30 INFO - Running setup.py (path:/tmp/pip-zAQzDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:30 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)) 06:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:30 INFO - Running setup.py (path:/tmp/pip-7d3x1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:30 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)) 06:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:30 INFO - Running setup.py (path:/tmp/pip-8k7HMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:31 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)) 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:31 INFO - Running setup.py (path:/tmp/pip-nJWtKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:31 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)) 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:31 INFO - Running setup.py (path:/tmp/pip-UlX8d1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:31 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)) 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:31 INFO - Running setup.py (path:/tmp/pip-euR22D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:31 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)) 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:31 INFO - Running setup.py (path:/tmp/pip-0IxRdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:31 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)) 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:31 INFO - Running setup.py (path:/tmp/pip-TGYQos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:31 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)) 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:31 INFO - Running setup.py (path:/tmp/pip-Or6IAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:31 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)) 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:31 INFO - Running setup.py (path:/tmp/pip-DuJyen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:31 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)) 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:31 INFO - Running setup.py (path:/tmp/pip-ZBLEKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:31 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)) 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:31 INFO - Running setup.py (path:/tmp/pip-mtTM4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:31 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)) 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:31 INFO - Running setup.py (path:/tmp/pip-oNebBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:31 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)) 06:12:31 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)) 06:12:31 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)) 06:12:31 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)) 06:12:31 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)) 06:12:31 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)) 06:12:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:33 INFO - Downloading blessings-1.6.tar.gz 06:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:12:33 INFO - Installing collected packages: blessings 06:12:33 INFO - Running setup.py install for blessings 06:12:33 INFO - Successfully installed blessings 06:12:33 INFO - Cleaning up... 06:12:33 INFO - Return code: 0 06:12:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:34 INFO - Reading from file tmpfile_stdout 06:12:34 INFO - Current package versions: 06:12:34 INFO - argparse == 1.2.1 06:12:34 INFO - blessings == 1.6 06:12:34 INFO - blobuploader == 1.2.4 06:12:34 INFO - docopt == 0.6.1 06:12:34 INFO - manifestparser == 1.1 06:12:34 INFO - mozInstall == 1.12 06:12:34 INFO - mozcrash == 0.17 06:12:34 INFO - mozdebug == 0.1 06:12:34 INFO - mozdevice == 0.48 06:12:34 INFO - mozfile == 1.2 06:12:34 INFO - mozhttpd == 0.7 06:12:34 INFO - mozinfo == 0.9 06:12:34 INFO - mozleak == 0.1 06:12:34 INFO - mozlog == 3.1 06:12:34 INFO - moznetwork == 0.27 06:12:34 INFO - mozprocess == 0.22 06:12:34 INFO - mozprofile == 0.28 06:12:34 INFO - mozrunner == 6.11 06:12:34 INFO - mozscreenshot == 0.1 06:12:34 INFO - mozsystemmonitor == 0.0 06:12:34 INFO - moztest == 0.7 06:12:34 INFO - mozversion == 1.4 06:12:34 INFO - psutil == 3.1.1 06:12:34 INFO - requests == 1.2.3 06:12:34 INFO - wsgiref == 0.1.2 06:12:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:34 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')]} 06:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:34 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')]} 06:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:34 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 0x7f9d0ca0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e410>, '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 0x173f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173f7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', '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 06:12:34 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 06:12:34 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 06:12:34 INFO - Using env: {'DISPLAY': ':0', 06:12:34 INFO - 'HOME': '/home/cltbld', 06:12:34 INFO - 'LANG': 'en_US.UTF-8', 06:12:34 INFO - 'LANGUAGE': 'en_US:en', 06:12:34 INFO - 'LOGNAME': 'cltbld', 06:12:34 INFO - 'MAIL': '/var/mail/cltbld', 06:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:34 INFO - 'MOZ_NO_REMOTE': '1', 06:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:34 INFO - 'NO_EM_RESTART': '1', 06:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:34 INFO - 'PWD': '/builds/slave/test', 06:12:34 INFO - 'SHELL': '/bin/bash', 06:12:34 INFO - 'SHLVL': '1', 06:12:34 INFO - 'TERM': 'linux', 06:12:34 INFO - 'TMOUT': '86400', 06:12:34 INFO - 'USER': 'cltbld', 06:12:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', 06:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:34 INFO - '_': '/tools/buildbot/bin/python'} 06:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:34 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)) 06:12:34 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)) 06:12:34 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)) 06:12:34 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)) 06:12:34 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)) 06:12:34 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)) 06:12:34 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)) 06:12:34 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)) 06:12:34 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)) 06:12:34 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)) 06:12:34 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)) 06:12:34 INFO - Cleaning up... 06:12:34 INFO - Return code: 0 06:12:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:12:34 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')]} 06:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:34 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')]} 06:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:34 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 0x7f9d0ca0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e410>, '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 0x173f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173f7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', '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 06:12:34 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 06:12:34 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 06:12:34 INFO - Using env: {'DISPLAY': ':0', 06:12:34 INFO - 'HOME': '/home/cltbld', 06:12:34 INFO - 'LANG': 'en_US.UTF-8', 06:12:34 INFO - 'LANGUAGE': 'en_US:en', 06:12:34 INFO - 'LOGNAME': 'cltbld', 06:12:34 INFO - 'MAIL': '/var/mail/cltbld', 06:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:34 INFO - 'MOZ_NO_REMOTE': '1', 06:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:34 INFO - 'NO_EM_RESTART': '1', 06:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:34 INFO - 'PWD': '/builds/slave/test', 06:12:34 INFO - 'SHELL': '/bin/bash', 06:12:34 INFO - 'SHLVL': '1', 06:12:34 INFO - 'TERM': 'linux', 06:12:34 INFO - 'TMOUT': '86400', 06:12:34 INFO - 'USER': 'cltbld', 06:12:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', 06:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:34 INFO - '_': '/tools/buildbot/bin/python'} 06:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:34 INFO - Downloading/unpacking jsonschema 06:12:34 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 06:12:34 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 06:12:34 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 06:12:34 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 06:12:34 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 06:12:34 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 06:12:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:12:36 INFO - Downloading/unpacking functools32 (from jsonschema) 06:12:36 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 06:12:36 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 06:12:36 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 06:12:36 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 06:12:36 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 06:12:36 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 06:12:36 INFO - Downloading functools32-3.2.3-2.tar.gz 06:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:12:36 INFO - warning: no files found matching '*.txt' 06:12:36 INFO - no previously-included directories found matching 'build' 06:12:36 INFO - no previously-included directories found matching 'dist' 06:12:36 INFO - no previously-included directories found matching '.git*' 06:12:36 INFO - Installing collected packages: jsonschema, functools32 06:12:36 INFO - Running setup.py install for functools32 06:12:36 INFO - warning: no files found matching '*.txt' 06:12:36 INFO - no previously-included directories found matching 'build' 06:12:36 INFO - no previously-included directories found matching 'dist' 06:12:36 INFO - no previously-included directories found matching '.git*' 06:12:36 INFO - Successfully installed jsonschema functools32 06:12:36 INFO - Cleaning up... 06:12:36 INFO - Return code: 0 06:12:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:12:36 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')]} 06:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:36 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')]} 06:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:36 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 0x7f9d0ca0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e410>, '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 0x173f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173f7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', '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 06:12:36 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 06:12:36 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 06:12:36 INFO - Using env: {'DISPLAY': ':0', 06:12:36 INFO - 'HOME': '/home/cltbld', 06:12:36 INFO - 'LANG': 'en_US.UTF-8', 06:12:36 INFO - 'LANGUAGE': 'en_US:en', 06:12:36 INFO - 'LOGNAME': 'cltbld', 06:12:36 INFO - 'MAIL': '/var/mail/cltbld', 06:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:36 INFO - 'MOZ_NO_REMOTE': '1', 06:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:36 INFO - 'NO_EM_RESTART': '1', 06:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:36 INFO - 'PWD': '/builds/slave/test', 06:12:36 INFO - 'SHELL': '/bin/bash', 06:12:36 INFO - 'SHLVL': '1', 06:12:36 INFO - 'TERM': 'linux', 06:12:36 INFO - 'TMOUT': '86400', 06:12:36 INFO - 'USER': 'cltbld', 06:12:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', 06:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:36 INFO - '_': '/tools/buildbot/bin/python'} 06:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:37 INFO - Downloading/unpacking flake8 06:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:12:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:12:38 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 06:12:38 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 06:12:38 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 06:12:38 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 06:12:38 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 06:12:38 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 06:12:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:12:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:12:39 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 06:12:39 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 06:12:39 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 06:12:39 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 06:12:39 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 06:12:39 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 06:12:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:12:39 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 06:12:39 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 06:12:39 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 06:12:39 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 06:12:39 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 06:12:39 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 06:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:12:39 INFO - no previously-included directories found matching 'docs/_build' 06:12:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:12:39 INFO - Running setup.py install for pep8 06:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:12:39 INFO - no previously-included directories found matching 'docs/_build' 06:12:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:12:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:12:39 INFO - Cleaning up... 06:12:39 INFO - Return code: 0 06:12:39 INFO - Running post-action listener: _resource_record_post_action 06:12:39 INFO - Running post-action listener: _start_resource_monitoring 06:12:39 INFO - Starting resource monitoring. 06:12:39 INFO - ##### 06:12:39 INFO - ##### Running install step. 06:12:39 INFO - ##### 06:12:39 INFO - Running pre-action listener: _resource_record_pre_action 06:12:39 INFO - Running main action method: install 06:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:40 INFO - Reading from file tmpfile_stdout 06:12:40 INFO - Detecting whether we're running mozinstall >=1.0... 06:12:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:12:40 INFO - Reading from file tmpfile_stdout 06:12:40 INFO - Output received: 06:12:40 INFO - Usage: mozinstall [options] installer 06:12:40 INFO - Options: 06:12:40 INFO - -h, --help show this help message and exit 06:12:40 INFO - -d DEST, --destination=DEST 06:12:40 INFO - Directory to install application into. [default: 06:12:40 INFO - "/builds/slave/test"] 06:12:40 INFO - --app=APP Application being installed. [default: firefox] 06:12:40 INFO - mkdir: /builds/slave/test/build/application 06:12:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:12:55 INFO - Reading from file tmpfile_stdout 06:12:55 INFO - Output received: 06:12:55 INFO - /builds/slave/test/build/application/firefox/firefox 06:12:55 INFO - Running post-action listener: _resource_record_post_action 06:12:55 INFO - ##### 06:12:55 INFO - ##### Running run-tests step. 06:12:55 INFO - ##### 06:12:55 INFO - Running pre-action listener: _resource_record_pre_action 06:12:55 INFO - Running main action method: run_tests 06:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:12:55 INFO - Python 2.7.3 06:12:55 INFO - Return code: 0 06:12:55 INFO - grabbing minidump binary from tooltool 06:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:55 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 0x173e410>, '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 0x173f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:12:55 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 06:12:55 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 06:12:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:12:55 INFO - Return code: 0 06:12:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:12:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:12:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:12:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:12:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:12:56 INFO - Return code: 0 06:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:12:56 INFO - Using env: {'DISPLAY': ':0', 06:12:56 INFO - 'HOME': '/home/cltbld', 06:12:56 INFO - 'LANG': 'en_US.UTF-8', 06:12:56 INFO - 'LANGUAGE': 'en_US:en', 06:12:56 INFO - 'LOGNAME': 'cltbld', 06:12:56 INFO - 'MAIL': '/var/mail/cltbld', 06:12:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:12:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:56 INFO - 'MOZ_NO_REMOTE': '1', 06:12:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:56 INFO - 'NO_EM_RESTART': '1', 06:12:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:56 INFO - 'PWD': '/builds/slave/test', 06:12:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:12:56 INFO - 'SHELL': '/bin/bash', 06:12:56 INFO - 'SHLVL': '1', 06:12:56 INFO - 'TERM': 'linux', 06:12:56 INFO - 'TMOUT': '86400', 06:12:56 INFO - 'USER': 'cltbld', 06:12:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329', 06:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:56 INFO - '_': '/tools/buildbot/bin/python'} 06:12:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:12:57 INFO - mozversion application_buildid: 20160601032755 06:12:57 INFO - mozversion application_changeset: 8b7e3ca6ddb7c3d7ad1dfd8b61ab18189e6ca1f3 06:12:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:12:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:12:57 INFO - mozversion application_name: Firefox 06:12:57 INFO - mozversion application_remotingname: firefox-dev 06:12:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:12:57 INFO - mozversion application_vendor: Mozilla 06:12:57 INFO - mozversion application_version: 48.0a2 06:12:57 INFO - mozversion platform_buildid: 20160601032755 06:12:57 INFO - mozversion platform_changeset: 8b7e3ca6ddb7c3d7ad1dfd8b61ab18189e6ca1f3 06:12:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:12:57 INFO - mozversion platform_version: 48.0a2 06:12:57 INFO - using testdate: 1464786777 06:12:57 INFO - actual date: 1464786777 06:12:57 INFO - starting webserver on 'localhost:58986' 06:12:57 INFO - SUITE-START | Running 2 tests 06:12:57 INFO - TEST-START | dromaeo_css 06:12:57 INFO - operating with platform_type : linux_ 06:12:57 INFO - Initialising browser for dromaeo_css test... 06:12:57 INFO - TEST-INFO | started process 6757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHR5a1Z/profile http://localhost:58986/getInfo.html) 06:13:01 INFO - PROCESS | 6757 | 06:13:01 INFO - PROCESS | 6757 | (process:6837): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:13:02 INFO - PROCESS | 6757 | __metrics Screen width/height:1600/1200 06:13:02 INFO - PROCESS | 6757 | colorDepth:24 06:13:02 INFO - PROCESS | 6757 | Browser inner width/height: 1024/697 06:13:02 INFO - PROCESS | 6757 | __metrics 06:13:02 ERROR - PROCESS | 6757 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 06:13:03 INFO - TEST-INFO | 6757: exit 0 06:13:03 INFO - Browser initialized. 06:13:03 INFO - Running cycle 1/1 for dromaeo_css test... 06:13:03 INFO - TEST-INFO | started process 6888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHR5a1Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:05 INFO - PROCESS | 6888 | 06:13:05 INFO - PROCESS | 6888 | (process:6954): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:13:15 INFO - PROCESS | 6888 | RSS: Main: 152223744 06:13:15 INFO - PROCESS | 6888 | 06:14:04 INFO - PROCESS | 6888 | 1464786844975 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:16:12 INFO - PROCESS | 6888 | Cycle 1(1): loaded http://localhost:58986/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58986/tests/dromaeo/cssquery-ext.html) 06:16:13 INFO - PROCESS | 6888 | RSS: Main: 155652096 06:16:13 INFO - PROCESS | 6888 | 06:19:15 INFO - PROCESS | 6888 | Cycle 1(1): loaded http://localhost:58986/tests/dromaeo/cssquery-ext.html (next: http://localhost:58986/tests/dromaeo/cssquery-jquery.html) 06:19:16 INFO - PROCESS | 6888 | RSS: Main: 153718784 06:19:16 INFO - PROCESS | 6888 | 06:22:17 INFO - PROCESS | 6888 | Cycle 1(1): loaded http://localhost:58986/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58986/tests/dromaeo/cssquery-mootools.html) 06:22:18 INFO - PROCESS | 6888 | RSS: Main: 153616384 06:22:18 INFO - PROCESS | 6888 | 06:25:20 INFO - PROCESS | 6888 | Cycle 1(1): loaded http://localhost:58986/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58986/tests/dromaeo/cssquery-prototype.html) 06:25:20 INFO - PROCESS | 6888 | RSS: Main: 153296896 06:25:20 INFO - PROCESS | 6888 | 06:28:22 INFO - PROCESS | 6888 | Cycle 1(1): loaded http://localhost:58986/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58986/tests/dromaeo/cssquery-yui.html) 06:28:23 INFO - PROCESS | 6888 | RSS: Main: 154705920 06:28:23 INFO - PROCESS | 6888 | 06:31:25 INFO - PROCESS | 6888 | Cycle 1(1): loaded http://localhost:58986/tests/dromaeo/cssquery-yui.html (next: http://localhost:58986/tests/dromaeo/cssquery-dojo.html) 06:31:25 INFO - PROCESS | 6888 | RSS: Main: 156508160 06:31:25 INFO - PROCESS | 6888 | 06:31:25 INFO - PROCESS | 6888 | __start_tp_report 06:31:25 INFO - PROCESS | 6888 | _x_x_mozilla_page_load 06:31:25 INFO - PROCESS | 6888 | _x_x_mozilla_page_load_details 06:31:25 INFO - PROCESS | 6888 | |i|pagename|runs| 06:31:25 INFO - PROCESS | 6888 | |0;dojo.html;3370.831458427079;3418.4530475123984;3428.5371474850886;3428.6914177724016;3468.7051600613945;5745.885082298357;5761.827145185641;5770.480656740892;5802.303723553175;5807.1579620954935;5746.683932383718;5777.971110144444;5806.042003069489;5824.912626310598;5846.795362162326;5120.46235145309;5159.32928719266;5194.454582268864;5194.896102077956;5222.973885130569;5103.055934652083;5248.895022099575;5288.894222115556;5315;5344.4922732340365;5166.612504062192;5172.120739474299;5183.740812959356;5278.815241466549;5304.071787437183;5196.844094677166;5212.76542555584;5212.947870521322;5218.347706536683;5228.92156617651;5077.441481437039;5115.2071428928575;5163.173892177234;5168.53483186515;5198.116320225533;5460.699661518614;5499.807506737245;5530.944690553123;5542.889142217174;5602.38373778884;6074.787382441594;6078.483328917047;6084.6349219047;6119.082137679384;6119.173911521976;6107.144999700045;6132.6013809102715;6138.048602466625;6138.877222455526;6141.293751218578;5691.971540142315;5703.74333155009;5730.828075157794;5744.511716504102;5768.451997060272;6196.225471816023;6197.318294987548;6203.069539569101;6204.751809927552;6212.285587157445;5986.461218490357;6011.398860114041;6011.699415029231;6038.6678732670125;6061.212042434456;6076.088586712029;6099.3900609938655;6110.528382738159;6138.785142519991;6144.56988010835;6092.786752463642;6097.878042439215;6104.664243466652;6108.358622344679;6124.35694252106;5846.327672317653;6017.608855424471;6059.8485037873525;6099;6133.957227271375;4669.089527542097;4680.438347398334;4682.274247491644;4684.227102528044;4691.81232750693;4160.022394737234;4172.5410204877435;4198.979005104955;4222.408862759216;4223.218704539609;5765.106408506688;5804.65172089676;5868.23712917318;5886.970565147147;5891.3814049525035;5989.520838332923;6097.359777223416;6176.629402235881;6189.907151392733;6205.689715514206;5876.6474011558585;5910.113482977502;5913.438223368773;5917.112433134978;5930.7924222652;5238.71187084714;5266.78932842682;5294.682319060868;5336.1195402758885;5364.678119312854;6267.968660156761;6300.779472718525;6312.274088479883;6315.084312774714;6324.936750632527;6175.2898416681755;6186.1339412483185;6187.690615469299;6194.752209911553;6198.473129784019;6138.815835524942;6216.285127210429;6263.530235232467;6300.275468321019;6310.148130002391;6103.389661033861;6108.02271636536;6110.450059494667;6118.235220597426;6140.048292514667;6002.549808764447;6212;6224.62652240867;6238.064290356483;6258.155149054819;5881.941180588139;5962.284525856751;5986.9401305986385;5994.07091900756;6011.308699499614;5931.110333449845;5940.435658612425;5940.702964851826;5942.959982003219;5962.731677074629;5734.569907257056;5856.912146317723;5859.179714839841;5862.12068189775;5951.345352011189;5919.082542205965;5956.642601443928;6020.488258498077;6033.064874944391;6041.546883983631;5824.039033559585;5829.47534721877;5877.206577112035;5892.793752218652;5935.258092738408 06:31:25 INFO - PROCESS | 6888 | |1;ext.html;667.4460198035631;674.8076798112537;696.7805141380468;728.91981881993;741.2069086077897;38543;39259.60740392592;39394.803025984904;39572.60427395725;39746.40380394293;41621.375679364835;42208;42259.78870105645;42294.15411691764;42504;8823.205911467967;8918.687845925393;8958.104189581056;8996.59515321812;8999.685011024616;8919;9085.682001129962;9087.273018158532;9095.317851161157;9117.589708463101;9071;9091.54542272887;9099.772505687344;9124.58939347731;9136.634534618608;8990.910090899106;9071.138241867013;9094.681686140986;9100.180983711432;9103.63585456581;9013.324000699973;9115.17963383292;9117.997020327759;9196.540172991323;9209.309301802392;41961.58038419607;42287.57712422867;42415.36376954348;42640.1471970562;42647;3694.113412780913;3733.757305775143;3809.1810260794064;3833.789141597239;3854.7879866607327;32828.835855820806;32988.50517242243;33024.1743956403;33296.3340733184;33403.16492087693;4520.434945631796;4624.190766615829;4650.488446270908;4653.0693861227555;4687.062587482517;318573;320275.9999999977;321491;322351;322432;37789.433158502645;59909.10136347958;60276.39723602796;60499;60628.69685651632;35676.64323356733;35886.641133588855;35911.28177436437;35998.28003439916;36038.63961360405;16992.915035424743;17226.569335766708;17252.654946901243;17277.049762262945;17333.653326933392;13307.534236301683;13335.533256335983;13439.798403023962;13456.058075934787;13483.393247303895;9110.407823491452;9198.448093114435;9200.35597508168;9238.122378374044;9277.396969196981;3548.6273941236313;3585.7848529088337;3586.569611646567;3606.2607165531003;3646.9635303646623;1061.4851796878509;1071.2982996137387;1094.8504070725705;1235.9876401236052;1278.3799857069314;32236.677633223837;32310.515342269886;32575.51136732951;32866.83566582152;32913.506297405555;1137.7838210739933;1145.7192987718063;1211.3277131192096;1284.9972336172755;1301.5184381778802;16909.577260568585;17103.74344384835;17204.91397543004;17359.739603905953;17468.388606398716;515502;620898;640359;643671;645639;59368;60184.39815601875;60426.69786651039;60454.69772651108;60679.393206067376;1345.3811246826374;1350.9662258443618;1363.720437310349;1366.9794953075711;1427.7358688642428;32203.194920127185;32850.34299313952;33104.83447582747;33288.667113328556;33503;52137;53508;53547;53622.19566706425;53656;431840;439496;439688;440470;440514;30006.849965750906;30482.695173048873;30492.695073048984;30512.389752205276;30548.84725576358;48757.268640971124;49243.50756492389;49569.25646115383;50025.24962125644;50180.74909625429;40677.59322406738;40997.795011024755;41463;42436.575634243265;42959.355609666505;42239;42341.78829105835;42692;42914.35628465638;43269.78365108154;37087.6291237095;42549.78725106355;43088.35367469428;43259.35110973275;44420.77789611031;43788.78105609579;43874.78062609794;43991;44351.55648443474;44906.55093449154;34003.4899476513;34368.48447273343;34901.8254908734;35197.82401088081;35553.933381998584 06:31:26 INFO - PROCESS | 6888 | |2;jquery.html;434.25091716788546;438.92538268494354;439.5648308174906;447.3245399446835;451.56424050791003;19295.710564341527;19781.109850056746;19921.402357929266;20204;20584;19140.712889306673;19357.322493712723;20584.176632934665;20636.69044964327;20691.793082069176;5560.388357280696;5739.512141467981;5797.188393624896;5803.796867109652;5825.126231065353;5920.555958303123;5934.732937017845;5959.672218028007;5961.284645842505;5975.462208401243;5909.172715819789;6380.840478988016;6411.903821442659;6457.6448295343735;6522.086907832907;6377.298497165308;6384.648844313561;6425.935740642581;6427.646479443629;6448.065030570588;5720.2849643794525;5824.883502329972;5825;5842.094475356326;5864.354920958691;14423.134611923213;14645.121292722471;18290.359837405627;24032.279031629078;24085.759142408526;2244.2930476899887;2266.3087758233733;2294.3231746634783;2373.988130059356;2455.6193789962585;10290.948545257226;10683.358998460117;10683.732906677395;10838.67483975482;11093.278936869077;1968.5767559974531;2037.4091513461078;2067.8138967492846;2068.503559145809;2157.870527768339;70014.64992675003;74456.6277168616;75628.62185689091;76172.61913690396;78026;11676.824847627293;11743.941280293544;11777;11870.643880683594;11896.821547676791;16460.6707865842;16538.338466461446;16560.83439165617;16639.50081497557;16655.83344166567;8760.167784060504;8872.689455869013;8945.73162805117;8958.328125390623;8979.14698103679;8601.870971935426;8612.311015118901;8658.528050231476;8693.652253909773;8818.250448711802;5014.17266151081;5075.0357432087785;5099.082165210298;5109.540141387293;5143.871403214949;2036.9898150509152;2096.09867756866;2122.5967066257363;2154.4398456401136;2186.562687462514;902.3457992955055;969.9903000970041;1051.5005372448027;1096.7093720164162;1133.4049623947328;19020.910504241656;19690.50773730668;19780;19888;19974.90012549928;1026.656070216486;1047.3297089862494;1053.9104176145113;1059.5814653211937;1088.298047759191;10902.563897444013;11083.445827708581;11095.611653592085;11144.60993865211;11167.329960202414;504241;507389;553778.0251785513;578951;596106;56632.433675662716;76325;77679;87355.56322218348;87831.56084219538;1086.9510872010778;1093.9343639381664;1097.665212110314;1121.3103941076179;1129.6441620889393;16608.169591520134;16865.662686745953;17025;17198.054107024233;17294.567635809206;35628;35689.46465803067;35696.64303357037;36184.09539761527;36766.44850327301;54032;54131.72934135304;54677.45322546724;54750;54918.72540637431;8296.87554686668;8654.956725216334;8776.824463510822;8867.113288671082;8888.777780555538;8324.334053275603;9655.372400793925;11037;12249.571265005681;12259.264444133381;6332.176817013758;8888.86666700013;11058.281211721212;11382.601608943647;11475.598354057567;9981.251406144713;10832.837507437238;10842.078423334106;10915.181361397768;10930.617428389969;11030.944845275722;11142.665720028412;11381.487833047699;11596.826047609124;11761.353125578175;9096.272298215994;9163.725088247364;9182.311326650395;9215.44707317563;9326.673566425143;8760.605772740115;10884.238103332691;11306.378149201873;11306.83039754388;11464.656060318204 06:31:26 INFO - PROCESS | 6888 | |3;mootools.html;1547.0872185410608;1567.3025503650877;1815.6096439265555;1906.9904650476747;1934.6711059119957;8099.068607110176;8218.424710270283;8342.791430214247;8485.321174306056;8710.695125670603;8907.910920890788;8978.86531702025;9034.186923176912;9039.864402033958;9064.501452420114;2414.9758502414925;2445.4742230420457;2450.424150324672;2455.7667021632915;2456.336789066951;2465.827392082555;2483.950320993588;2500.2249302716127;2501.249625112468;2501.799856011524;2449.963250551243;2454.7299797022315;2469.4814089041324;2474.7030356357263;2481.081999660128;2452.950940981188;2456.2140115163156;2474.4308808973856;2490.203134996802;2507.448361360498;2437.6587277781123;2453.3621258472926;2493.13986674597;2518.244526642;2518.9118380856767;8686.913130868674;8754.124587541259;8756.737297881074;8758.343124265706;8766.211041006276;5285.312909321802;5405;5422.810201642963;5443.156310771837;5465.234867118566;3364.142143753327;3400.251944572215;3425.5033020212177;3467.7052450541732;3509.6841284284537;1088.9564417423294;1106.7343837479027;1109.8890110988916;1110.1285490889693;1110.6445937300068;11999.760004799942;12018.4591693374;12048.277103373826;12054.15620906537;12128.090393220455;4501.099780044005;4525.230710779176;4620.445546534437;4629.328747331618;4656.906861862743;9617.27870409722;9642.614295428104;9701.6604418845;9748.805023899482;9764.804703905882;5289.127293996447;5300.337457817773;5330.520253177233;5336.2529245904825;5348.465153484698;4413.646908247332;4784.067106914118;4867.610591152699;4936.432310284292;5003.899922001612;3930.21395720857;3946.6842652587725;4044.5753195914594;4076.4700588923843;4091.468109145792;1232.5994051933158;1244.321844594698;1251.6307689231699;1260.2690439545042;1260.5966090851023;1043.8642976413169;1045.1899777672213;1049.968500944973;1056.7886422715487;1066.2376400873413;5906.675132867734;5992.161097446361;6044;6064.545159113084;6166.290876549165;449.9572540608637;452.85055931542513;453.12546784705836;457.5036085846827;462.28807636240487;4336.718113322624;4367.672424568106;4371.956280437155;4388.29787234041;4408.515063343029;9982.201423886072;10002.649907253211;10169.440680762482;10183.54174062169;10240.948795255976;9902.752431189278;10171.593136274614;10185.134263587677;10185.439800811026;10282.177425805918;8098.595070246464;8263.214994575506;8315.95842020786;8324.167583241628;8376.748697539084;5911.497522710618;6067.393260673897;6104.786332478519;6109.389061093855;6192.195014648067;9424.481653509123;9448.338616296793;9481.336306458757;9494.572744226389;9584.520773961414;9625.229981601595;9790.657326993805;9801.75495612587;9861.901380986385;9885;6835.93164068353;7120.252373500708;7343.082114735658;7715.614219289126;7798.596252674573;8060.31487323584;8107.1892810718455;8122.065962414162;8184.386171037077;8197.303229225583;7156.892646610409;7236.421086312977;7265.782026539212;7283.417326613964;7522.322990930843;7072.363487285963;7376.446766492427;7393.55638661682;7475.588842613708;7579.279968402993;6831.351021652935;6883;6930.930690693029;6937.306269373023;6950.409215216763;5254.500822421864;5414.918776218438;5458.0721277382145;5583.860403489945;5635;5365.517103460551;5401.3248343957;5416.079266524622;5430.619856609999;5450.209719590716 06:31:26 INFO - PROCESS | 6888 | |4;prototype.html;357.77102654301234;361.6636528028933;367.20683324020115;367.68002869697796;372.22205590316236;6598.10925525054;6685.799426017215;6688.197416310038;6780.457563394935;6839.418649414793;6628.270890202074;6687.832804179898;6722.260551339361;6725.529212955095;6734;4989.675671081386;4993.825216117437;4994.650374473788;4996.300517927493;5011.123053465647;4995.975020124913;4997.900041999158;4999.800007999694;5008.574271186935;5015.473375295596;4953.950460495403;4958.206686930092;4959.181735013718;4969.2049272116465;4972.353594032771;4704.458987216445;4938.925916111261;4944.159492886218;4961.875953101166;4978.2034874419915;4221.050263690645;4223.788810559459;4225.704200705952;4252.55348188442;4259.70182087254;6254.437100660963;6305.0857625644485;6339.778107766252;6346.714397852108;6356.523260755462;5817.0983497557945;5820.097884827858;5820.1560773688;5829.09649004405;5830.067189249742;6977.267386924402;6980.127484064492;6986.930130698679;7002.334778196063;7004.614746188958;4793.520647935214;4805.687630304019;4813.422389313305;4819.975900120477;4838.032393521275;7062.470314726364;7136.3220494052985;7144.464165187632;7263.12842458903;7279.563226206445;5078.466760990117;5081.974590127025;5083.161278389099;5083.694978301313;5105.132127538327;5143.3827940646615;5147.562457191106;5155.046316431472;5165.070287348238;5167.689938603696;5886.264216972879;5898.174255604219;5915;5916.881662366729;5931.703414829241;6846.281140480278;6951.756688515878;7012.9298707013295;7031.824204394931;7045.471589630798;1796.4700413378084;1812.275089964025;1823.9544011399555;1824.36147348427;1825.9360922367919;1190.7261329894172;1194.4505527457293;1200.5677955935855;1212.3150420012664;1215.3437143942172;6729.596224226562;6894.24163342032;6948.583085014915;6987.266337034538;6991.091158149408;7358.96320518394;7361.447891408166;7374.705011799468;7382.483226174117;7389.8152546186775;6842.281560436182;6848.828779280558;6873.450123990069;6886.24251332353;6890.758823441155;3945.5659877413464;3980.5024371953505;3985.103351745892;3986.8604598839484;4000.8399664013114;7255.129384473791;7558.735444259424;7592.468527203043;7593.848123037619;7603.315701586884;7401.296876796696;7408.444366672521;7449.739259125905;7450.925490745023;7475.813104672427;7561.281678240558;7568.053993250844;7568.848623027508;7573.242675732493;7580.886286705704;7261.49169558147;7291.234420385996;7324.937884006896;7328.706851726084;7335.3398194160645;7231.204567497676;7231.710731570678;7250.9637451812405;7254.202037775946;7276.4178865689555;7502.549847009197;7527.962360188164;7536.811579710551;7556.508826926232;7583.090029196532;4827.613790896649;4859.1010663027455;4859.4654587996;4863.635227357891;4864.464908860094;7040.577565346096;7285.307895749896;7308.451866110169;7312.122545294599;7312.378447831994;7034.753783617549;7101.893471597827;7149.606771627402;7152.24901385347;7158.284171583008;7057.823554411181;7112.146542414944;7131.964340178266;7131.964340178266;7136.857262854817;6927.618980955895;6987.09167808202;6996.405305549085;6997.47518936092;7008.474364422586;6991.091158149408;7123.928760712534;7157.964210178916;7162.7493037743425;7168.1756597989815;6802.523823332319;6974.19796723363;6976.372126508639;6979.232284448605;7016.964915175596 06:31:26 INFO - PROCESS | 6888 | |5;yui.html;784.211867073591;828.7803732011014;864.5115509736999;875.1205038935868;890.243293200779;13835.308234588269;14016.088954217968;14018.929905350484;14034.298285085755;14040.157590544562;13637.863621363807;13714.108582942103;13738.107023043494;13773.724525509484;13805.654858628513;874.8818909447207;885.8671199320089;889.4796544021755;890.7505898348472;890.9287257019455;749.7863109013932;859.325429537813;882.3514716683233;883.1433509495779;883.6067949762358;933.8039011807529;934.2479304160182;934.8364036293622;935.3546053223288;936.929730270229;932.2495391210073;932.3566738950136;932.5943214701558;934.0099494535814;934.9532523373838;687.0141347166832;688.9965550172217;690.2407351912906;690.837653151509;690.9930900690979;14192.858071419258;14258.786118208236;14294.142351458946;14388.568342949728;14408.783868241984;14238.501652442115;14421.351039203157;14503;14761.926190369088;15115.546533604009;11662.650120496399;11868.643940681794;11905.404729763477;11961;12206.816897746541;4068.776217308047;4110.301248787713;4111.403846442249;4137.606927341898;4261.296886013804;55033.449665503234;55342;55699.72150139264;55831;55891.72054139744;11016.449177541092;11297.604583839691;11306.152038597138;11438.370889601152;11464.541418343173;19683.409497715093;19872.10575524076;19893.60212795736;19906.60186796285;19921.60156796856;8569.228769410658;8633.697820576375;8642.09258027898;8650.524221167896;8717.346199035097;4786;4813.807447702053;4818.975905120452;4848.539388758062;4892.535209155125;3556.093196234995;3576.284743051348;3601.981990090033;3610.765300255475;3611.368010598135;660.4782222044531;683.4668958212602;701.1586096684;709.2729951799344;722.3823630795699;736.3851184261202;753.3784627682185;760;771.3058247577113;771.8263390737039;8530.957345213359;8834.514101724468;9517.857232141523;9597.136257736836;9604.423734575948;710.7512370670224;717.6698718589507;769.1692971590669;797.0992778160642;824.9711260105987;4667.159911215946;4700;4771.832985845479;4919.262110683426;4930.285108659296;66024.33975660279;66115;66443.33556664371;66533.33466665368;66975;56905.71547142238;57213;57255.71372143113;57439.13841292384;57530;51155;52291.73854130705;52597.73701131546;52917.470825292025;53556.46443535515;9140.542972851465;9182.540872956459;9349.345545811728;9360.251179905456;9449;37817;38334;38717.419238712006;39614.60385396109;39668.40497392599;44977.10045799131;49836.501634984634;50595.74702126466;51452.22821657603;51523.742381287855;11483.138764592855;11537.250078744855;11699.649010529698;11701.648950531498;11846.11154163424;12741.745165096461;12781.16922400041;13019.283939383045;13084.084114112302;13299.268540229994;12578.119531632698;12776.872231277568;12874;13031.47874085064;13110;12524.248545087325;12594.811077833656;12845.486180553047;13193.40629671648;13278.269695166859;11229.157813164209;11233.32600044;11275.436228188722;11413.60052398162;11422.543098275975;9396.76508087276;9556.187724043533;9770.902290977;9997.900020999698;10091.69724908254;10658.576261714166;10695.893041069801;10737.516811743333;10809.459527023775;10862.674119776419 06:31:26 INFO - PROCESS | 6888 | __end_tp_report 06:31:26 INFO - PROCESS | 6888 | __start_cc_report 06:31:26 INFO - PROCESS | 6888 | _x_x_mozilla_cycle_collect,345 06:31:26 INFO - PROCESS | 6888 | __end_cc_report 06:31:26 INFO - PROCESS | 6888 | __startTimestamp1464787885991__endTimestamp 06:31:26 INFO - PROCESS | 6888 | 06:31:26 INFO - PROCESS | 6888 | ------- Summary: start ------- 06:31:26 INFO - PROCESS | 6888 | Number of tests: 6 06:31:26 INFO - PROCESS | 6888 | 06:31:26 INFO - PROCESS | 6888 | [#0] dojo.html Cycles:165 Average:5688.17 Median:5913.44 stddev:628.89 (10.6%) stddev-sans-first:603.97 06:31:26 INFO - PROCESS | 6888 | Values: 3370.8 3418.5 3428.5 3428.7 3468.7 5745.9 5761.8 5770.5 5802.3 5807.2 5746.7 5778.0 5806.0 5824.9 5846.8 5120.5 5159.3 5194.5 5194.9 5223.0 5103.1 5248.9 5288.9 5315.0 5344.5 5166.6 5172.1 5183.7 5278.8 5304.1 5196.8 5212.8 5212.9 5218.3 5228.9 5077.4 5115.2 5163.2 5168.5 5198.1 5460.7 5499.8 5530.9 5542.9 5602.4 6074.8 6078.5 6084.6 6119.1 6119.2 6107.1 6132.6 6138.0 6138.9 6141.3 5692.0 5703.7 5730.8 5744.5 5768.5 6196.2 6197.3 6203.1 6204.8 6212.3 5986.5 6011.4 6011.7 6038.7 6061.2 6076.1 6099.4 6110.5 6138.8 6144.6 6092.8 6097.9 6104.7 6108.4 6124.4 5846.3 6017.6 6059.8 6099.0 6134.0 4669.1 4680.4 4682.3 4684.2 4691.8 4160.0 4172.5 4199.0 4222.4 4223.2 5765.1 5804.7 5868.2 5887.0 5891.4 5989.5 6097.4 6176.6 6189.9 6205.7 5876.6 5910.1 5913.4 5917.1 5930.8 5238.7 5266.8 5294.7 5336.1 5364.7 6268.0 6300.8 6312.3 6315.1 6324.9 6175.3 6186.1 6187.7 6194.8 6198.5 6138.8 6216.3 6263.5 6300.3 6310.1 6103.4 6108.0 6110.5 6118.2 6140.0 6002.5 6212.0 6224.6 6238.1 6258.2 5881.9 5962.3 5986.9 5994.1 6011.3 5931.1 5940.4 5940.7 5943.0 5962.7 5734.6 5856.9 5859.2 5862.1 5951.3 5919.1 5956.6 6020.5 6033.1 6041.5 5824.0 5829.5 5877.2 5892.8 5935.3 06:31:26 INFO - PROCESS | 6888 | 06:31:26 INFO - PROCESS | 6888 | [#1] ext.html Cycles:180 Average:61240.21 Median:42290.87 stddev:126322.72 (298.7%) stddev-sans-first:126595.22 06:31:26 INFO - PROCESS | 6888 | Values: 667.4 674.8 696.8 728.9 741.2 38543.0 39259.6 39394.8 39572.6 39746.4 41621.4 42208.0 42259.8 42294.2 42504.0 8823.2 8918.7 8958.1 8996.6 8999.7 8919.0 9085.7 9087.3 9095.3 9117.6 9071.0 9091.5 9099.8 9124.6 9136.6 8990.9 9071.1 9094.7 9100.2 9103.6 9013.3 9115.2 9118.0 9196.5 9209.3 41961.6 42287.6 42415.4 42640.1 42647.0 3694.1 3733.8 3809.2 3833.8 3854.8 32828.8 32988.5 33024.2 33296.3 33403.2 4520.4 4624.2 4650.5 4653.1 4687.1 318573.0 320276.0 321491.0 322351.0 322432.0 37789.4 59909.1 60276.4 60499.0 60628.7 35676.6 35886.6 35911.3 35998.3 36038.6 16992.9 17226.6 17252.7 17277.0 17333.7 13307.5 13335.5 13439.8 13456.1 13483.4 9110.4 9198.4 9200.4 9238.1 9277.4 3548.6 3585.8 3586.6 3606.3 3647.0 1061.5 1071.3 1094.9 1236.0 1278.4 32236.7 32310.5 32575.5 32866.8 32913.5 1137.8 1145.7 1211.3 1285.0 1301.5 16909.6 17103.7 17204.9 17359.7 17468.4 515502.0 620898.0 640359.0 643671.0 645639.0 59368.0 60184.4 60426.7 60454.7 60679.4 1345.4 1351.0 1363.7 1367.0 1427.7 32203.2 32850.3 33104.8 33288.7 33503.0 52137.0 53508.0 53547.0 53622.2 53656.0 431840.0 439496.0 439688.0 440470.0 440514.0 30006.8 30482.7 30492.7 30512.4 30548.8 48757.3 49243.5 49569.3 50025.2 50180.7 40677.6 40997.8 41463.0 42436.6 42959.4 42239.0 42341.8 42692.0 42914.4 43269.8 37087.6 42549.8 43088.4 43259.4 44420.8 43788.8 43874.8 43991.0 44351.6 44906.6 34003.5 34368.5 34901.8 35197.8 35553.9 06:31:26 INFO - PROCESS | 6888 | 06:31:26 INFO - PROCESS | 6888 | [#2] jquery.html Cycles:180 Average:29747.22 Median:13270.69 stddev:89928.02 (677.6%) stddev-sans-first:90153.35 06:31:26 INFO - PROCESS | 6888 | Values: 434.3 438.9 439.6 447.3 451.6 19295.7 19781.1 19921.4 20204.0 20584.0 19140.7 19357.3 20584.2 20636.7 20691.8 5560.4 5739.5 5797.2 5803.8 5825.1 5920.6 5934.7 5959.7 5961.3 5975.5 5909.2 6380.8 6411.9 6457.6 6522.1 6377.3 6384.6 6425.9 6427.6 6448.1 5720.3 5824.9 5825.0 5842.1 5864.4 14423.1 14645.1 18290.4 24032.3 24085.8 2244.3 2266.3 2294.3 2374.0 2455.6 10290.9 10683.4 10683.7 10838.7 11093.3 1968.6 2037.4 2067.8 2068.5 2157.9 70014.6 74456.6 75628.6 76172.6 78026.0 11676.8 11743.9 11777.0 11870.6 11896.8 16460.7 16538.3 16560.8 16639.5 16655.8 8760.2 8872.7 8945.7 8958.3 8979.1 8601.9 8612.3 8658.5 8693.7 8818.3 5014.2 5075.0 5099.1 5109.5 5143.9 2037.0 2096.1 2122.6 2154.4 2186.6 902.3 970.0 1051.5 1096.7 1133.4 19020.9 19690.5 19780.0 19888.0 19974.9 1026.7 1047.3 1053.9 1059.6 1088.3 10902.6 11083.4 11095.6 11144.6 11167.3 504241.0 507389.0 553778.0 578951.0 596106.0 56632.4 76325.0 77679.0 87355.6 87831.6 1087.0 1093.9 1097.7 1121.3 1129.6 16608.2 16865.7 17025.0 17198.1 17294.6 35628.0 35689.5 35696.6 36184.1 36766.4 54032.0 54131.7 54677.5 54750.0 54918.7 8296.9 8655.0 8776.8 8867.1 8888.8 8324.3 9655.4 11037.0 12249.6 12259.3 6332.2 8888.9 11058.3 11382.6 11475.6 9981.3 10832.8 10842.1 10915.2 10930.6 11030.9 11142.7 11381.5 11596.8 11761.4 9096.3 9163.7 9182.3 9215.4 9326.7 8760.6 10884.2 11306.4 11306.8 11464.7 06:31:26 INFO - PROCESS | 6888 | 06:31:26 INFO - PROCESS | 6888 | [#3] mootools.html Cycles:180 Average:5713.04 Median:5294.73 stddev:3111.38 (58.8%) stddev-sans-first:3104.36 06:31:26 INFO - PROCESS | 6888 | Values: 1547.1 1567.3 1815.6 1907.0 1934.7 8099.1 8218.4 8342.8 8485.3 8710.7 8907.9 8978.9 9034.2 9039.9 9064.5 2415.0 2445.5 2450.4 2455.8 2456.3 2465.8 2484.0 2500.2 2501.2 2501.8 2450.0 2454.7 2469.5 2474.7 2481.1 2453.0 2456.2 2474.4 2490.2 2507.4 2437.7 2453.4 2493.1 2518.2 2518.9 8686.9 8754.1 8756.7 8758.3 8766.2 5285.3 5405.0 5422.8 5443.2 5465.2 3364.1 3400.3 3425.5 3467.7 3509.7 1089.0 1106.7 1109.9 1110.1 1110.6 11999.8 12018.5 12048.3 12054.2 12128.1 4501.1 4525.2 4620.4 4629.3 4656.9 9617.3 9642.6 9701.7 9748.8 9764.8 5289.1 5300.3 5330.5 5336.3 5348.5 4413.6 4784.1 4867.6 4936.4 5003.9 3930.2 3946.7 4044.6 4076.5 4091.5 1232.6 1244.3 1251.6 1260.3 1260.6 1043.9 1045.2 1050.0 1056.8 1066.2 5906.7 5992.2 6044.0 6064.5 6166.3 450.0 452.9 453.1 457.5 462.3 4336.7 4367.7 4372.0 4388.3 4408.5 9982.2 10002.6 10169.4 10183.5 10240.9 9902.8 10171.6 10185.1 10185.4 10282.2 8098.6 8263.2 8316.0 8324.2 8376.7 5911.5 6067.4 6104.8 6109.4 6192.2 9424.5 9448.3 9481.3 9494.6 9584.5 9625.2 9790.7 9801.8 9861.9 9885.0 6835.9 7120.3 7343.1 7715.6 7798.6 8060.3 8107.2 8122.1 8184.4 8197.3 7156.9 7236.4 7265.8 7283.4 7522.3 7072.4 7376.4 7393.6 7475.6 7579.3 6831.4 6883.0 6930.9 6937.3 6950.4 5254.5 5414.9 5458.1 5583.9 5635.0 5365.5 5401.3 5416.1 5430.6 5450.2 06:31:26 INFO - PROCESS | 6888 | 06:31:26 INFO - PROCESS | 6888 | [#4] prototype.html Cycles:180 Average:5897.66 Median:6820.97 stddev:1794.81 (26.3%) stddev-sans-first:1751.01 06:31:26 INFO - PROCESS | 6888 | Values: 357.8 361.7 367.2 367.7 372.2 6598.1 6685.8 6688.2 6780.5 6839.4 6628.3 6687.8 6722.3 6725.5 6734.0 4989.7 4993.8 4994.7 4996.3 5011.1 4996.0 4997.9 4999.8 5008.6 5015.5 4954.0 4958.2 4959.2 4969.2 4972.4 4704.5 4938.9 4944.2 4961.9 4978.2 4221.1 4223.8 4225.7 4252.6 4259.7 6254.4 6305.1 6339.8 6346.7 6356.5 5817.1 5820.1 5820.2 5829.1 5830.1 6977.3 6980.1 6986.9 7002.3 7004.6 4793.5 4805.7 4813.4 4820.0 4838.0 7062.5 7136.3 7144.5 7263.1 7279.6 5078.5 5082.0 5083.2 5083.7 5105.1 5143.4 5147.6 5155.0 5165.1 5167.7 5886.3 5898.2 5915.0 5916.9 5931.7 6846.3 6951.8 7012.9 7031.8 7045.5 1796.5 1812.3 1824.0 1824.4 1825.9 1190.7 1194.5 1200.6 1212.3 1215.3 6729.6 6894.2 6948.6 6987.3 6991.1 7359.0 7361.4 7374.7 7382.5 7389.8 6842.3 6848.8 6873.5 6886.2 6890.8 3945.6 3980.5 3985.1 3986.9 4000.8 7255.1 7558.7 7592.5 7593.8 7603.3 7401.3 7408.4 7449.7 7450.9 7475.8 7561.3 7568.1 7568.8 7573.2 7580.9 7261.5 7291.2 7324.9 7328.7 7335.3 7231.2 7231.7 7251.0 7254.2 7276.4 7502.5 7528.0 7536.8 7556.5 7583.1 4827.6 4859.1 4859.5 4863.6 4864.5 7040.6 7285.3 7308.5 7312.1 7312.4 7034.8 7101.9 7149.6 7152.2 7158.3 7057.8 7112.1 7132.0 7132.0 7136.9 6927.6 6987.1 6996.4 6997.5 7008.5 6991.1 7123.9 7158.0 7162.7 7168.2 6802.5 6974.2 6976.4 6979.2 7017.0 06:31:26 INFO - PROCESS | 6888 | 06:31:26 INFO - PROCESS | 6888 | [#5] yui.html Cycles:180 Average:15391.26 Median:4924.77 stddev:18124.68 (368.0%) stddev-sans-first:18142.33 06:31:26 INFO - PROCESS | 6888 | Values: 784.2 828.8 864.5 875.1 890.2 13835.3 14016.1 14018.9 14034.3 14040.2 13637.9 13714.1 13738.1 13773.7 13805.7 874.9 885.9 889.5 890.8 890.9 749.8 859.3 882.4 883.1 883.6 933.8 934.2 934.8 935.4 936.9 932.2 932.4 932.6 934.0 935.0 687.0 689.0 690.2 690.8 691.0 14192.9 14258.8 14294.1 14388.6 14408.8 14238.5 14421.4 14503.0 14761.9 15115.5 11662.7 11868.6 11905.4 11961.0 12206.8 4068.8 4110.3 4111.4 4137.6 4261.3 55033.4 55342.0 55699.7 55831.0 55891.7 11016.4 11297.6 11306.2 11438.4 11464.5 19683.4 19872.1 19893.6 19906.6 19921.6 8569.2 8633.7 8642.1 8650.5 8717.3 4786.0 4813.8 4819.0 4848.5 4892.5 3556.1 3576.3 3602.0 3610.8 3611.4 660.5 683.5 701.2 709.3 722.4 736.4 753.4 760.0 771.3 771.8 8531.0 8834.5 9517.9 9597.1 9604.4 710.8 717.7 769.2 797.1 825.0 4667.2 4700.0 4771.8 4919.3 4930.3 66024.3 66115.0 66443.3 66533.3 66975.0 56905.7 57213.0 57255.7 57439.1 57530.0 51155.0 52291.7 52597.7 52917.5 53556.5 9140.5 9182.5 9349.3 9360.3 9449.0 37817.0 38334.0 38717.4 39614.6 39668.4 44977.1 49836.5 50595.7 51452.2 51523.7 11483.1 11537.3 11699.6 11701.6 11846.1 12741.7 12781.2 13019.3 13084.1 13299.3 12578.1 12776.9 12874.0 13031.5 13110.0 12524.2 12594.8 12845.5 13193.4 13278.3 11229.2 11233.3 11275.4 11413.6 11422.5 9396.8 9556.2 9770.9 9997.9 10091.7 10658.6 10695.9 10737.5 10809.5 10862.7 06:31:26 INFO - PROCESS | 6888 | -------- Summary: end -------- 06:31:26 INFO - PROCESS | 6888 | 06:31:26 INFO - TEST-INFO | 6888: exit 0 06:31:26 INFO - TEST-OK | dromaeo_css | took 1109579ms 06:31:26 INFO - TEST-START | kraken 06:31:26 INFO - operating with platform_type : linux_ 06:31:26 INFO - Initialising browser for kraken test... 06:31:26 INFO - TEST-INFO | started process 7133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Nc4U0/profile http://localhost:58986/getInfo.html) 06:31:30 INFO - PROCESS | 7133 | 06:31:30 INFO - PROCESS | 7133 | (process:7214): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:31:31 INFO - PROCESS | 7133 | __metrics Screen width/height:1600/1200 06:31:31 INFO - PROCESS | 7133 | colorDepth:24 06:31:31 INFO - PROCESS | 7133 | Browser inner width/height: 1024/697 06:31:31 INFO - PROCESS | 7133 | __metrics 06:31:32 ERROR - PROCESS | 7133 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 06:31:33 INFO - TEST-INFO | 7133: exit 0 06:31:33 INFO - Browser initialized. 06:31:33 INFO - Running cycle 1/1 for kraken test... 06:31:33 INFO - TEST-INFO | started process 7265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Nc4U0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:35 INFO - PROCESS | 7265 | 06:31:35 INFO - PROCESS | 7265 | (process:7336): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:31:45 INFO - PROCESS | 7265 | RSS: Main: 152477696 06:31:45 INFO - PROCESS | 7265 | 06:31:47 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58986/tests/kraken/driver.html?testName=audio-beat-detection) 06:31:48 INFO - PROCESS | 7265 | RSS: Main: 157130752 06:31:48 INFO - PROCESS | 7265 | 06:31:51 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58986/tests/kraken/driver.html?testName=audio-dft) 06:31:51 INFO - PROCESS | 7265 | RSS: Main: 157532160 06:31:51 INFO - PROCESS | 7265 | 06:31:54 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58986/tests/kraken/driver.html?testName=audio-fft) 06:31:55 INFO - PROCESS | 7265 | RSS: Main: 157601792 06:31:55 INFO - PROCESS | 7265 | 06:31:57 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58986/tests/kraken/driver.html?testName=audio-oscillator) 06:31:57 INFO - PROCESS | 7265 | RSS: Main: 157130752 06:31:57 INFO - PROCESS | 7265 | 06:32:00 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58986/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:32:00 INFO - PROCESS | 7265 | RSS: Main: 157081600 06:32:00 INFO - PROCESS | 7265 | 06:32:03 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58986/tests/kraken/driver.html?testName=imaging-darkroom) 06:32:04 INFO - PROCESS | 7265 | RSS: Main: 157097984 06:32:04 INFO - PROCESS | 7265 | 06:32:07 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58986/tests/kraken/driver.html?testName=imaging-desaturate) 06:32:08 INFO - PROCESS | 7265 | RSS: Main: 157028352 06:32:08 INFO - PROCESS | 7265 | 06:32:11 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58986/tests/kraken/driver.html?testName=json-parse-financial) 06:32:11 INFO - PROCESS | 7265 | RSS: Main: 157417472 06:32:11 INFO - PROCESS | 7265 | 06:32:13 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58986/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:32:14 INFO - PROCESS | 7265 | RSS: Main: 157478912 06:32:14 INFO - PROCESS | 7265 | 06:32:15 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58986/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:32:16 INFO - PROCESS | 7265 | RSS: Main: 157859840 06:32:16 INFO - PROCESS | 7265 | 06:32:18 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58986/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:32:19 INFO - PROCESS | 7265 | RSS: Main: 157720576 06:32:19 INFO - PROCESS | 7265 | 06:32:21 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:32:22 INFO - PROCESS | 7265 | RSS: Main: 158302208 06:32:22 INFO - PROCESS | 7265 | 06:32:24 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:32:25 INFO - PROCESS | 7265 | RSS: Main: 158060544 06:32:25 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:58986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58986/tests/kraken/driver.html?testName=ai-astar) 06:32:27 INFO - PROCESS | 7265 | RSS: Main: 159485952 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | __start_tp_report 06:32:27 INFO - PROCESS | 7265 | _x_x_mozilla_page_load 06:32:27 INFO - PROCESS | 7265 | _x_x_mozilla_page_load_details 06:32:27 INFO - PROCESS | 7265 | |i|pagename|runs| 06:32:27 INFO - PROCESS | 7265 | |0;ai-astar;107;110;104;109;110;112;101;111;112;112 06:32:27 INFO - PROCESS | 7265 | |1;audio-beat-detection;151;132;158;175;132;155;166;130;192;132 06:32:27 INFO - PROCESS | 7265 | |2;audio-dft;162;162;162;163;163;162;163;162;161;162 06:32:27 INFO - PROCESS | 7265 | |3;audio-fft;76;75;76;186;77;77;74;77;157;76 06:32:27 INFO - PROCESS | 7265 | |4;audio-oscillator;92;93;153;93;93;92;143;94;93;155 06:32:27 INFO - PROCESS | 7265 | |5;imaging-gaussian-blur;118;118;118;118;130;117;118;117;117;119 06:32:27 INFO - PROCESS | 7265 | |6;imaging-darkroom;146;146;147;146;146;150;151;146;146;146 06:32:27 INFO - PROCESS | 7265 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 06:32:27 INFO - PROCESS | 7265 | |8;json-parse-financial;55;58;62;57;59;59;60;82;56;56 06:32:27 INFO - PROCESS | 7265 | |9;json-stringify-tinderbox;58;58;58;58;59;58;59;58;59;59 06:32:27 INFO - PROCESS | 7265 | |10;stanford-crypto-aes;74;74;72;73;75;73;74;82;74;80 06:32:27 INFO - PROCESS | 7265 | |11;stanford-crypto-ccm;120;123;115;117;116;113;113;112;131;133 06:32:27 INFO - PROCESS | 7265 | |12;stanford-crypto-pbkdf2;163;156;157;156;158;158;156;155;158;155 06:32:27 INFO - PROCESS | 7265 | |13;stanford-crypto-sha256-iterative;68;76;68;71;66;67;69;65;64;65 06:32:27 INFO - PROCESS | 7265 | __end_tp_report 06:32:27 INFO - PROCESS | 7265 | __start_cc_report 06:32:27 INFO - PROCESS | 7265 | _x_x_mozilla_cycle_collect,870 06:32:27 INFO - PROCESS | 7265 | __end_cc_report 06:32:27 INFO - PROCESS | 7265 | __startTimestamp1464787947349__endTimestamp 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | ------- Summary: start ------- 06:32:27 INFO - PROCESS | 7265 | Number of tests: 14 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.74 (3.4%) stddev-sans-first:3.91 06:32:27 INFO - PROCESS | 7265 | Values: 107.0 110.0 104.0 109.0 110.0 112.0 101.0 111.0 112.0 112.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:156.50 stddev:21.22 (13.6%) stddev-sans-first:22.51 06:32:27 INFO - PROCESS | 7265 | Values: 151.0 132.0 158.0 175.0 132.0 155.0 166.0 130.0 192.0 132.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:32:27 INFO - PROCESS | 7265 | Values: 162.0 162.0 162.0 163.0 163.0 162.0 163.0 162.0 161.0 162.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:40.85 (53.8%) stddev-sans-first:42.74 06:32:27 INFO - PROCESS | 7265 | Values: 76.0 75.0 76.0 186.0 77.0 77.0 74.0 77.0 157.0 76.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.00 stddev:27.93 (30.0%) stddev-sans-first:28.85 06:32:27 INFO - PROCESS | 7265 | Values: 92.0 93.0 153.0 93.0 93.0 92.0 143.0 94.0 93.0 155.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#5] imaging-gaussian-blur Cycles:10 Average:119.00 Median:118.00 stddev:3.92 (3.3%) stddev-sans-first:4.14 06:32:27 INFO - PROCESS | 7265 | Values: 118.0 118.0 118.0 118.0 130.0 117.0 118.0 117.0 117.0 119.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:146.00 stddev:1.89 (1.3%) stddev-sans-first:1.96 06:32:27 INFO - PROCESS | 7265 | Values: 146.0 146.0 147.0 146.0 146.0 150.0 151.0 146.0 146.0 146.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:32:27 INFO - PROCESS | 7265 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:59.00 stddev:7.88 (13.4%) stddev-sans-first:8.11 06:32:27 INFO - PROCESS | 7265 | Values: 55.0 58.0 62.0 57.0 59.0 59.0 60.0 82.0 56.0 56.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 06:32:27 INFO - PROCESS | 7265 | Values: 58.0 58.0 58.0 58.0 59.0 58.0 59.0 58.0 59.0 59.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.00 stddev:3.25 (4.4%) stddev-sans-first:3.42 06:32:27 INFO - PROCESS | 7265 | Values: 74.0 74.0 72.0 73.0 75.0 73.0 74.0 82.0 74.0 80.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:118.50 stddev:7.50 (6.3%) stddev-sans-first:7.95 06:32:27 INFO - PROCESS | 7265 | Values: 120.0 123.0 115.0 117.0 116.0 113.0 113.0 112.0 131.0 133.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:157.50 stddev:2.35 (1.5%) stddev-sans-first:1.24 06:32:27 INFO - PROCESS | 7265 | Values: 163.0 156.0 157.0 156.0 158.0 158.0 156.0 155.0 158.0 155.0 06:32:27 INFO - PROCESS | 7265 | 06:32:27 INFO - PROCESS | 7265 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:3.54 (5.2%) stddev-sans-first:3.76 06:32:27 INFO - PROCESS | 7265 | Values: 68.0 76.0 68.0 71.0 66.0 67.0 69.0 65.0 64.0 65.0 06:32:27 INFO - PROCESS | 7265 | -------- Summary: end -------- 06:32:27 INFO - PROCESS | 7265 | 06:32:28 INFO - TEST-INFO | 7265: exit 0 06:32:28 INFO - TEST-OK | kraken | took 61679ms 06:32:28 INFO - SUITE-END | took 1171s 06:32:28 INFO - Completed test suite (00:19:31) 06:32:28 INFO - javascript benchmark 06:32:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.831458427079, 3418.4530475123984, 3428.5371474850886, 3428.6914177724016, 3468.7051600613945, 5745.885082298357, 5761.827145185641, 5770.480656740892, 5802.303723553175, 5807.1579620954935, 5746.683932383718, 5777.971110144444, 5806.042003069489, 5824.912626310598, 5846.795362162326, 5120.46235145309, 5159.32928719266, 5194.454582268864, 5194.896102077956, 5222.973885130569, 5103.055934652083, 5248.895022099575, 5288.894222115556, 5315.0, 5344.4922732340365, 5166.612504062192, 5172.120739474299, 5183.740812959356, 5278.815241466549, 5304.071787437183, 5196.844094677166, 5212.76542555584, 5212.947870521322, 5218.347706536683, 5228.92156617651, 5077.441481437039, 5115.2071428928575, 5163.173892177234, 5168.53483186515, 5198.116320225533, 5460.699661518614, 5499.807506737245, 5530.944690553123, 5542.889142217174, 5602.38373778884, 6074.787382441594, 6078.483328917047, 6084.6349219047, 6119.082137679384, 6119.173911521976, 6107.144999700045, 6132.6013809102715, 6138.048602466625, 6138.877222455526, 6141.293751218578, 5691.971540142315, 5703.74333155009, 5730.828075157794, 5744.511716504102, 5768.451997060272, 6196.225471816023, 6197.318294987548, 6203.069539569101, 6204.751809927552, 6212.285587157445, 5986.461218490357, 6011.398860114041, 6011.699415029231, 6038.6678732670125, 6061.212042434456, 6076.088586712029, 6099.3900609938655, 6110.528382738159, 6138.785142519991, 6144.56988010835, 6092.786752463642, 6097.878042439215, 6104.664243466652, 6108.358622344679, 6124.35694252106, 5846.327672317653, 6017.608855424471, 6059.8485037873525, 6099.0, 6133.957227271375, 4669.089527542097, 4680.438347398334, 4682.274247491644, 4684.227102528044, 4691.81232750693, 4160.022394737234, 4172.5410204877435, 4198.979005104955, 4222.408862759216, 4223.218704539609, 5765.106408506688, 5804.65172089676, 5868.23712917318, 5886.970565147147, 5891.3814049525035, 5989.520838332923, 6097.359777223416, 6176.629402235881, 6189.907151392733, 6205.689715514206, 5876.6474011558585, 5910.113482977502, 5913.438223368773, 5917.112433134978, 5930.7924222652, 5238.71187084714, 5266.78932842682, 5294.682319060868, 5336.1195402758885, 5364.678119312854, 6267.968660156761, 6300.779472718525, 6312.274088479883, 6315.084312774714, 6324.936750632527, 6175.2898416681755, 6186.1339412483185, 6187.690615469299, 6194.752209911553, 6198.473129784019, 6138.815835524942, 6216.285127210429, 6263.530235232467, 6300.275468321019, 6310.148130002391, 6103.389661033861, 6108.02271636536, 6110.450059494667, 6118.235220597426, 6140.048292514667, 6002.549808764447, 6212.0, 6224.62652240867, 6238.064290356483, 6258.155149054819, 5881.941180588139, 5962.284525856751, 5986.9401305986385, 5994.07091900756, 6011.308699499614, 5931.110333449845, 5940.435658612425, 5940.702964851826, 5942.959982003219, 5962.731677074629, 5734.569907257056, 5856.912146317723, 5859.179714839841, 5862.12068189775, 5951.345352011189, 5919.082542205965, 5956.642601443928, 6020.488258498077, 6033.064874944391, 6041.546883983631, 5824.039033559585, 5829.47534721877, 5877.206577112035, 5892.793752218652, 5935.258092738408], "value": 5647.266730320293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.4460198035631, 674.8076798112537, 696.7805141380468, 728.91981881993, 741.2069086077897, 38543.0, 39259.60740392592, 39394.803025984904, 39572.60427395725, 39746.40380394293, 41621.375679364835, 42208.0, 42259.78870105645, 42294.15411691764, 42504.0, 8823.205911467967, 8918.687845925393, 8958.104189581056, 8996.59515321812, 8999.685011024616, 8919.0, 9085.682001129962, 9087.273018158532, 9095.317851161157, 9117.589708463101, 9071.0, 9091.54542272887, 9099.772505687344, 9124.58939347731, 9136.634534618608, 8990.910090899106, 9071.138241867013, 9094.681686140986, 9100.180983711432, 9103.63585456581, 9013.324000699973, 9115.17963383292, 9117.997020327759, 9196.540172991323, 9209.309301802392, 41961.58038419607, 42287.57712422867, 42415.36376954348, 42640.1471970562, 42647.0, 3694.113412780913, 3733.757305775143, 3809.1810260794064, 3833.789141597239, 3854.7879866607327, 32828.835855820806, 32988.50517242243, 33024.1743956403, 33296.3340733184, 33403.16492087693, 4520.434945631796, 4624.190766615829, 4650.488446270908, 4653.0693861227555, 4687.062587482517, 318573.0, 320275.9999999977, 321491.0, 322351.0, 322432.0, 37789.433158502645, 59909.10136347958, 60276.39723602796, 60499.0, 60628.69685651632, 35676.64323356733, 35886.641133588855, 35911.28177436437, 35998.28003439916, 36038.63961360405, 16992.915035424743, 17226.569335766708, 17252.654946901243, 17277.049762262945, 17333.653326933392, 13307.534236301683, 13335.533256335983, 13439.798403023962, 13456.058075934787, 13483.393247303895, 9110.407823491452, 9198.448093114435, 9200.35597508168, 9238.122378374044, 9277.396969196981, 3548.6273941236313, 3585.7848529088337, 3586.569611646567, 3606.2607165531003, 3646.9635303646623, 1061.4851796878509, 1071.2982996137387, 1094.8504070725705, 1235.9876401236052, 1278.3799857069314, 32236.677633223837, 32310.515342269886, 32575.51136732951, 32866.83566582152, 32913.506297405555, 1137.7838210739933, 1145.7192987718063, 1211.3277131192096, 1284.9972336172755, 1301.5184381778802, 16909.577260568585, 17103.74344384835, 17204.91397543004, 17359.739603905953, 17468.388606398716, 515502.0, 620898.0, 640359.0, 643671.0, 645639.0, 59368.0, 60184.39815601875, 60426.69786651039, 60454.69772651108, 60679.393206067376, 1345.3811246826374, 1350.9662258443618, 1363.720437310349, 1366.9794953075711, 1427.7358688642428, 32203.194920127185, 32850.34299313952, 33104.83447582747, 33288.667113328556, 33503.0, 52137.0, 53508.0, 53547.0, 53622.19566706425, 53656.0, 431840.0, 439496.0, 439688.0, 440470.0, 440514.0, 30006.849965750906, 30482.695173048873, 30492.695073048984, 30512.389752205276, 30548.84725576358, 48757.268640971124, 49243.50756492389, 49569.25646115383, 50025.24962125644, 50180.74909625429, 40677.59322406738, 40997.795011024755, 41463.0, 42436.575634243265, 42959.355609666505, 42239.0, 42341.78829105835, 42692.0, 42914.35628465638, 43269.78365108154, 37087.6291237095, 42549.78725106355, 43088.35367469428, 43259.35110973275, 44420.77789611031, 43788.78105609579, 43874.78062609794, 43991.0, 44351.55648443474, 44906.55093449154, 34003.4899476513, 34368.48447273343, 34901.8254908734, 35197.82401088081, 35553.933381998584], "value": 19774.980705145656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.25091716788546, 438.92538268494354, 439.5648308174906, 447.3245399446835, 451.56424050791003, 19295.710564341527, 19781.109850056746, 19921.402357929266, 20204.0, 20584.0, 19140.712889306673, 19357.322493712723, 20584.176632934665, 20636.69044964327, 20691.793082069176, 5560.388357280696, 5739.512141467981, 5797.188393624896, 5803.796867109652, 5825.126231065353, 5920.555958303123, 5934.732937017845, 5959.672218028007, 5961.284645842505, 5975.462208401243, 5909.172715819789, 6380.840478988016, 6411.903821442659, 6457.6448295343735, 6522.086907832907, 6377.298497165308, 6384.648844313561, 6425.935740642581, 6427.646479443629, 6448.065030570588, 5720.2849643794525, 5824.883502329972, 5825.0, 5842.094475356326, 5864.354920958691, 14423.134611923213, 14645.121292722471, 18290.359837405627, 24032.279031629078, 24085.759142408526, 2244.2930476899887, 2266.3087758233733, 2294.3231746634783, 2373.988130059356, 2455.6193789962585, 10290.948545257226, 10683.358998460117, 10683.732906677395, 10838.67483975482, 11093.278936869077, 1968.5767559974531, 2037.4091513461078, 2067.8138967492846, 2068.503559145809, 2157.870527768339, 70014.64992675003, 74456.6277168616, 75628.62185689091, 76172.61913690396, 78026.0, 11676.824847627293, 11743.941280293544, 11777.0, 11870.643880683594, 11896.821547676791, 16460.6707865842, 16538.338466461446, 16560.83439165617, 16639.50081497557, 16655.83344166567, 8760.167784060504, 8872.689455869013, 8945.73162805117, 8958.328125390623, 8979.14698103679, 8601.870971935426, 8612.311015118901, 8658.528050231476, 8693.652253909773, 8818.250448711802, 5014.17266151081, 5075.0357432087785, 5099.082165210298, 5109.540141387293, 5143.871403214949, 2036.9898150509152, 2096.09867756866, 2122.5967066257363, 2154.4398456401136, 2186.562687462514, 902.3457992955055, 969.9903000970041, 1051.5005372448027, 1096.7093720164162, 1133.4049623947328, 19020.910504241656, 19690.50773730668, 19780.0, 19888.0, 19974.90012549928, 1026.656070216486, 1047.3297089862494, 1053.9104176145113, 1059.5814653211937, 1088.298047759191, 10902.563897444013, 11083.445827708581, 11095.611653592085, 11144.60993865211, 11167.329960202414, 504241.0, 507389.0, 553778.0251785513, 578951.0, 596106.0, 56632.433675662716, 76325.0, 77679.0, 87355.56322218348, 87831.56084219538, 1086.9510872010778, 1093.9343639381664, 1097.665212110314, 1121.3103941076179, 1129.6441620889393, 16608.169591520134, 16865.662686745953, 17025.0, 17198.054107024233, 17294.567635809206, 35628.0, 35689.46465803067, 35696.64303357037, 36184.09539761527, 36766.44850327301, 54032.0, 54131.72934135304, 54677.45322546724, 54750.0, 54918.72540637431, 8296.87554686668, 8654.956725216334, 8776.824463510822, 8867.113288671082, 8888.777780555538, 8324.334053275603, 9655.372400793925, 11037.0, 12249.571265005681, 12259.264444133381, 6332.176817013758, 8888.86666700013, 11058.281211721212, 11382.601608943647, 11475.598354057567, 9981.251406144713, 10832.837507437238, 10842.078423334106, 10915.181361397768, 10930.617428389969, 11030.944845275722, 11142.665720028412, 11381.487833047699, 11596.826047609124, 11761.353125578175, 9096.272298215994, 9163.725088247364, 9182.311326650395, 9215.44707317563, 9326.673566425143, 8760.605772740115, 10884.238103332691, 11306.378149201873, 11306.83039754388, 11464.656060318204], "value": 9288.18684441252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1547.0872185410608, 1567.3025503650877, 1815.6096439265555, 1906.9904650476747, 1934.6711059119957, 8099.068607110176, 8218.424710270283, 8342.791430214247, 8485.321174306056, 8710.695125670603, 8907.910920890788, 8978.86531702025, 9034.186923176912, 9039.864402033958, 9064.501452420114, 2414.9758502414925, 2445.4742230420457, 2450.424150324672, 2455.7667021632915, 2456.336789066951, 2465.827392082555, 2483.950320993588, 2500.2249302716127, 2501.249625112468, 2501.799856011524, 2449.963250551243, 2454.7299797022315, 2469.4814089041324, 2474.7030356357263, 2481.081999660128, 2452.950940981188, 2456.2140115163156, 2474.4308808973856, 2490.203134996802, 2507.448361360498, 2437.6587277781123, 2453.3621258472926, 2493.13986674597, 2518.244526642, 2518.9118380856767, 8686.913130868674, 8754.124587541259, 8756.737297881074, 8758.343124265706, 8766.211041006276, 5285.312909321802, 5405.0, 5422.810201642963, 5443.156310771837, 5465.234867118566, 3364.142143753327, 3400.251944572215, 3425.5033020212177, 3467.7052450541732, 3509.6841284284537, 1088.9564417423294, 1106.7343837479027, 1109.8890110988916, 1110.1285490889693, 1110.6445937300068, 11999.760004799942, 12018.4591693374, 12048.277103373826, 12054.15620906537, 12128.090393220455, 4501.099780044005, 4525.230710779176, 4620.445546534437, 4629.328747331618, 4656.906861862743, 9617.27870409722, 9642.614295428104, 9701.6604418845, 9748.805023899482, 9764.804703905882, 5289.127293996447, 5300.337457817773, 5330.520253177233, 5336.2529245904825, 5348.465153484698, 4413.646908247332, 4784.067106914118, 4867.610591152699, 4936.432310284292, 5003.899922001612, 3930.21395720857, 3946.6842652587725, 4044.5753195914594, 4076.4700588923843, 4091.468109145792, 1232.5994051933158, 1244.321844594698, 1251.6307689231699, 1260.2690439545042, 1260.5966090851023, 1043.8642976413169, 1045.1899777672213, 1049.968500944973, 1056.7886422715487, 1066.2376400873413, 5906.675132867734, 5992.161097446361, 6044.0, 6064.545159113084, 6166.290876549165, 449.9572540608637, 452.85055931542513, 453.12546784705836, 457.5036085846827, 462.28807636240487, 4336.718113322624, 4367.672424568106, 4371.956280437155, 4388.29787234041, 4408.515063343029, 9982.201423886072, 10002.649907253211, 10169.440680762482, 10183.54174062169, 10240.948795255976, 9902.752431189278, 10171.593136274614, 10185.134263587677, 10185.439800811026, 10282.177425805918, 8098.595070246464, 8263.214994575506, 8315.95842020786, 8324.167583241628, 8376.748697539084, 5911.497522710618, 6067.393260673897, 6104.786332478519, 6109.389061093855, 6192.195014648067, 9424.481653509123, 9448.338616296793, 9481.336306458757, 9494.572744226389, 9584.520773961414, 9625.229981601595, 9790.657326993805, 9801.75495612587, 9861.901380986385, 9885.0, 6835.93164068353, 7120.252373500708, 7343.082114735658, 7715.614219289126, 7798.596252674573, 8060.31487323584, 8107.1892810718455, 8122.065962414162, 8184.386171037077, 8197.303229225583, 7156.892646610409, 7236.421086312977, 7265.782026539212, 7283.417326613964, 7522.322990930843, 7072.363487285963, 7376.446766492427, 7393.55638661682, 7475.588842613708, 7579.279968402993, 6831.351021652935, 6883.0, 6930.930690693029, 6937.306269373023, 6950.409215216763, 5254.500822421864, 5414.918776218438, 5458.0721277382145, 5583.860403489945, 5635.0, 5365.517103460551, 5401.3248343957, 5416.079266524622, 5430.619856609999, 5450.209719590716], "value": 4577.010843979971, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.77102654301234, 361.6636528028933, 367.20683324020115, 367.68002869697796, 372.22205590316236, 6598.10925525054, 6685.799426017215, 6688.197416310038, 6780.457563394935, 6839.418649414793, 6628.270890202074, 6687.832804179898, 6722.260551339361, 6725.529212955095, 6734.0, 4989.675671081386, 4993.825216117437, 4994.650374473788, 4996.300517927493, 5011.123053465647, 4995.975020124913, 4997.900041999158, 4999.800007999694, 5008.574271186935, 5015.473375295596, 4953.950460495403, 4958.206686930092, 4959.181735013718, 4969.2049272116465, 4972.353594032771, 4704.458987216445, 4938.925916111261, 4944.159492886218, 4961.875953101166, 4978.2034874419915, 4221.050263690645, 4223.788810559459, 4225.704200705952, 4252.55348188442, 4259.70182087254, 6254.437100660963, 6305.0857625644485, 6339.778107766252, 6346.714397852108, 6356.523260755462, 5817.0983497557945, 5820.097884827858, 5820.1560773688, 5829.09649004405, 5830.067189249742, 6977.267386924402, 6980.127484064492, 6986.930130698679, 7002.334778196063, 7004.614746188958, 4793.520647935214, 4805.687630304019, 4813.422389313305, 4819.975900120477, 4838.032393521275, 7062.470314726364, 7136.3220494052985, 7144.464165187632, 7263.12842458903, 7279.563226206445, 5078.466760990117, 5081.974590127025, 5083.161278389099, 5083.694978301313, 5105.132127538327, 5143.3827940646615, 5147.562457191106, 5155.046316431472, 5165.070287348238, 5167.689938603696, 5886.264216972879, 5898.174255604219, 5915.0, 5916.881662366729, 5931.703414829241, 6846.281140480278, 6951.756688515878, 7012.9298707013295, 7031.824204394931, 7045.471589630798, 1796.4700413378084, 1812.275089964025, 1823.9544011399555, 1824.36147348427, 1825.9360922367919, 1190.7261329894172, 1194.4505527457293, 1200.5677955935855, 1212.3150420012664, 1215.3437143942172, 6729.596224226562, 6894.24163342032, 6948.583085014915, 6987.266337034538, 6991.091158149408, 7358.96320518394, 7361.447891408166, 7374.705011799468, 7382.483226174117, 7389.8152546186775, 6842.281560436182, 6848.828779280558, 6873.450123990069, 6886.24251332353, 6890.758823441155, 3945.5659877413464, 3980.5024371953505, 3985.103351745892, 3986.8604598839484, 4000.8399664013114, 7255.129384473791, 7558.735444259424, 7592.468527203043, 7593.848123037619, 7603.315701586884, 7401.296876796696, 7408.444366672521, 7449.739259125905, 7450.925490745023, 7475.813104672427, 7561.281678240558, 7568.053993250844, 7568.848623027508, 7573.242675732493, 7580.886286705704, 7261.49169558147, 7291.234420385996, 7324.937884006896, 7328.706851726084, 7335.3398194160645, 7231.204567497676, 7231.710731570678, 7250.9637451812405, 7254.202037775946, 7276.4178865689555, 7502.549847009197, 7527.962360188164, 7536.811579710551, 7556.508826926232, 7583.090029196532, 4827.613790896649, 4859.1010663027455, 4859.4654587996, 4863.635227357891, 4864.464908860094, 7040.577565346096, 7285.307895749896, 7308.451866110169, 7312.122545294599, 7312.378447831994, 7034.753783617549, 7101.893471597827, 7149.606771627402, 7152.24901385347, 7158.284171583008, 7057.823554411181, 7112.146542414944, 7131.964340178266, 7131.964340178266, 7136.857262854817, 6927.618980955895, 6987.09167808202, 6996.405305549085, 6997.47518936092, 7008.474364422586, 6991.091158149408, 7123.928760712534, 7157.964210178916, 7162.7493037743425, 7168.1756597989815, 6802.523823332319, 6974.19796723363, 6976.372126508639, 6979.232284448605, 7016.964915175596], "value": 5313.192104630589, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.211867073591, 828.7803732011014, 864.5115509736999, 875.1205038935868, 890.243293200779, 13835.308234588269, 14016.088954217968, 14018.929905350484, 14034.298285085755, 14040.157590544562, 13637.863621363807, 13714.108582942103, 13738.107023043494, 13773.724525509484, 13805.654858628513, 874.8818909447207, 885.8671199320089, 889.4796544021755, 890.7505898348472, 890.9287257019455, 749.7863109013932, 859.325429537813, 882.3514716683233, 883.1433509495779, 883.6067949762358, 933.8039011807529, 934.2479304160182, 934.8364036293622, 935.3546053223288, 936.929730270229, 932.2495391210073, 932.3566738950136, 932.5943214701558, 934.0099494535814, 934.9532523373838, 687.0141347166832, 688.9965550172217, 690.2407351912906, 690.837653151509, 690.9930900690979, 14192.858071419258, 14258.786118208236, 14294.142351458946, 14388.568342949728, 14408.783868241984, 14238.501652442115, 14421.351039203157, 14503.0, 14761.926190369088, 15115.546533604009, 11662.650120496399, 11868.643940681794, 11905.404729763477, 11961.0, 12206.816897746541, 4068.776217308047, 4110.301248787713, 4111.403846442249, 4137.606927341898, 4261.296886013804, 55033.449665503234, 55342.0, 55699.72150139264, 55831.0, 55891.72054139744, 11016.449177541092, 11297.604583839691, 11306.152038597138, 11438.370889601152, 11464.541418343173, 19683.409497715093, 19872.10575524076, 19893.60212795736, 19906.60186796285, 19921.60156796856, 8569.228769410658, 8633.697820576375, 8642.09258027898, 8650.524221167896, 8717.346199035097, 4786.0, 4813.807447702053, 4818.975905120452, 4848.539388758062, 4892.535209155125, 3556.093196234995, 3576.284743051348, 3601.981990090033, 3610.765300255475, 3611.368010598135, 660.4782222044531, 683.4668958212602, 701.1586096684, 709.2729951799344, 722.3823630795699, 736.3851184261202, 753.3784627682185, 760.0, 771.3058247577113, 771.8263390737039, 8530.957345213359, 8834.514101724468, 9517.857232141523, 9597.136257736836, 9604.423734575948, 710.7512370670224, 717.6698718589507, 769.1692971590669, 797.0992778160642, 824.9711260105987, 4667.159911215946, 4700.0, 4771.832985845479, 4919.262110683426, 4930.285108659296, 66024.33975660279, 66115.0, 66443.33556664371, 66533.33466665368, 66975.0, 56905.71547142238, 57213.0, 57255.71372143113, 57439.13841292384, 57530.0, 51155.0, 52291.73854130705, 52597.73701131546, 52917.470825292025, 53556.46443535515, 9140.542972851465, 9182.540872956459, 9349.345545811728, 9360.251179905456, 9449.0, 37817.0, 38334.0, 38717.419238712006, 39614.60385396109, 39668.40497392599, 44977.10045799131, 49836.501634984634, 50595.74702126466, 51452.22821657603, 51523.742381287855, 11483.138764592855, 11537.250078744855, 11699.649010529698, 11701.648950531498, 11846.11154163424, 12741.745165096461, 12781.16922400041, 13019.283939383045, 13084.084114112302, 13299.268540229994, 12578.119531632698, 12776.872231277568, 12874.0, 13031.47874085064, 13110.0, 12524.248545087325, 12594.811077833656, 12845.486180553047, 13193.40629671648, 13278.269695166859, 11229.157813164209, 11233.32600044, 11275.436228188722, 11413.60052398162, 11422.543098275975, 9396.76508087276, 9556.187724043533, 9770.902290977, 9997.900020999698, 10091.69724908254, 10658.576261714166, 10695.893041069801, 10737.516811743333, 10809.459527023775, 10862.674119776419], "value": 7006.429405147578, "unit": "score"}], "name": "dromaeo_css", "value": 7491.336721792389, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 104.0, 109.0, 110.0, 112.0, 101.0, 111.0, 112.0, 112.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 132.0, 158.0, 175.0, 132.0, 155.0, 166.0, 130.0, 192.0, 132.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 163.0, 162.0, 163.0, 162.0, 161.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 186.0, 77.0, 77.0, 74.0, 77.0, 157.0, 76.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 153.0, 93.0, 93.0, 92.0, 143.0, 94.0, 93.0, 155.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 130.0, 117.0, 118.0, 117.0, 117.0, 119.0], "value": 119.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 150.0, 151.0, 146.0, 146.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 62.0, 57.0, 59.0, 59.0, 60.0, 82.0, 56.0, 56.0], "value": 60.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 72.0, 73.0, 75.0, 73.0, 74.0, 82.0, 74.0, 80.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 123.0, 115.0, 117.0, 116.0, 113.0, 113.0, 112.0, 131.0, 133.0], "value": 119.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 156.0, 157.0, 156.0, 158.0, 158.0, 156.0, 155.0, 158.0, 155.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 68.0, 71.0, 66.0, 67.0, 69.0, 65.0, 64.0, 65.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1527.9, "alertThreshold": 2.0}]} 06:32:28 INFO - Return code: 0 06:32:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:32:28 ERROR - # TBPL SUCCESS # 06:32:28 INFO - Running post-action listener: _resource_record_post_action 06:32:28 INFO - Running post-run listener: _resource_record_post_run 06:32:29 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507367424; Read time: 16; Write time: 508336 06:32:29 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 256585728; Read time: 0; Write time: 321372 06:32:29 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 246714368; Read time: 16; Write time: 186400 06:32:29 INFO - Running post-run listener: _upload_blobber_files 06:32:29 INFO - Blob upload gear active. 06:32:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:32:29 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:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:32:30 INFO - (blobuploader) - INFO - Open directory for files ... 06:32:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:32:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:32:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:30 INFO - (blobuploader) - INFO - Done attempting. 06:32:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:32:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:32:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:31 INFO - (blobuploader) - INFO - Done attempting. 06:32:31 INFO - (blobuploader) - INFO - Iteration through files over. 06:32:31 INFO - Return code: 0 06:32:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:32:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:32:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83069e8cd47845851854f342f16c96c2869caf6e2ef623a23b62ab5488276ad986c86c05fe25b8d70071d7f6f94cc14165b0323060824730bb78a78dd298208d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d91fb812d9d4a0858a3768fae0b5053630e511db262823c336c49f6bee4a353ea19d0db602f9c3b3efeb22d3d516a7d8deec0646eb6cb981fd11ba7b5f424624"} 06:32:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:32:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:32:31 INFO - Contents: 06:32:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83069e8cd47845851854f342f16c96c2869caf6e2ef623a23b62ab5488276ad986c86c05fe25b8d70071d7f6f94cc14165b0323060824730bb78a78dd298208d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d91fb812d9d4a0858a3768fae0b5053630e511db262823c336c49f6bee4a353ea19d0db602f9c3b3efeb22d3d516a7d8deec0646eb6cb981fd11ba7b5f424624"} 06:32:31 INFO - Running post-run listener: copy_logs_to_upload_dir 06:32:31 INFO - Copying logs to upload dir... 06:32:31 INFO - mkdir: /builds/slave/test/build/upload/logs 06:32:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.447741 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-01 06:32:31.465588) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 06:32:31.469034) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83069e8cd47845851854f342f16c96c2869caf6e2ef623a23b62ab5488276ad986c86c05fe25b8d70071d7f6f94cc14165b0323060824730bb78a78dd298208d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d91fb812d9d4a0858a3768fae0b5053630e511db262823c336c49f6bee4a353ea19d0db602f9c3b3efeb22d3d516a7d8deec0646eb6cb981fd11ba7b5f424624"} build_url:https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011806 build_url: 'https://queue.taskcluster.net/v1/task/QpRhLXXqSJ-90LztSji_Uw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83069e8cd47845851854f342f16c96c2869caf6e2ef623a23b62ab5488276ad986c86c05fe25b8d70071d7f6f94cc14165b0323060824730bb78a78dd298208d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d91fb812d9d4a0858a3768fae0b5053630e511db262823c336c49f6bee4a353ea19d0db602f9c3b3efeb22d3d516a7d8deec0646eb6cb981fd11ba7b5f424624"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 06:32:31.495951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:32:31.496371) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464786723.56947-1363500329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:32:31.578459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 06:32:31.578789) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 06:32:31.579106) ========= ========= Total master_lag: 0.15 =========