builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1462529705.07 results: success (0) buildid: 20160505123841 builduid: 1457772db7ef4c1982b4796b67a4914d revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.065583) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.065961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.066376) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.099900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.100209) ========= 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=0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 03:15: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.5M=0s 2016-05-06 03:15:05 (23.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076750 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.192812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.193096) ========= 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=0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016481 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.246112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 03:15:05.246426) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --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 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --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=0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 03:15:05,807 truncating revision to first 12 chars 2016-05-06 03:15:05,807 Setting DEBUG logging. 2016-05-06 03:15:05,807 attempt 1/10 2016-05-06 03:15:05,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0123e9f41ced?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 03:15:06,234 unpacking tar archive at: mozilla-aurora-0123e9f41ced/testing/mozharness/ program finished with exit code 0 elapsedTime=1.016685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 03:15:06.278559) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:06.278856) ========= script_repo_revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:06.279248) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:06.279521) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:06.287376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-06 03:15:06.287674) ========= /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=0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:15:06 INFO - MultiFileLogger online at 20160506 03:15:06 in /builds/slave/test 03:15: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 03:15:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:15:06 INFO - {'append_to_log': False, 03:15:06 INFO - 'base_work_dir': '/builds/slave/test', 03:15:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:15:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:15:06 INFO - 'branch': 'Mozilla-Aurora', 03:15:06 INFO - 'buildbot_json_path': 'buildprops.json', 03:15:06 INFO - 'config_files': ('talos/linux_config.py',), 03:15:06 INFO - 'default_actions': ('clobber', 03:15:06 INFO - 'read-buildbot-config', 03:15:06 INFO - 'download-and-extract', 03:15:06 INFO - 'populate-webroot', 03:15:06 INFO - 'create-virtualenv', 03:15:06 INFO - 'install', 03:15:06 INFO - 'run-tests'), 03:15:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:15:06 INFO - 'download_minidump_stackwalk': True, 03:15:06 INFO - 'download_symbols': 'ondemand', 03:15:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:15:06 INFO - 'tooltool.py': '/tools/tooltool.py', 03:15:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:15:06 INFO - '/tools/misc-python/virtualenv.py')}, 03:15:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:15:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:15:06 INFO - 'installer_path': 'installer.exe', 03:15:06 INFO - 'log_level': 'info', 03:15:06 INFO - 'log_name': 'talos', 03:15:06 INFO - 'log_to_console': True, 03:15:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:15:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:15:06 INFO - 'opt_config_files': (), 03:15:06 INFO - 'pip_index': False, 03:15:06 INFO - 'sps_profile': False, 03:15:06 INFO - 'sps_profile_interval': 0, 03:15:06 INFO - 'suite': 'dromaeojs-e10s', 03:15:06 INFO - 'system_bits': '32', 03:15:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:15:06 INFO - 'title': 'talos-linux64-ix-017', 03:15:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:15:06 INFO - 'use_talos_json': True, 03:15:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:15:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:15:06 INFO - 'work_dir': 'build'} 03:15:06 INFO - ##### 03:15:06 INFO - ##### Running clobber step. 03:15:06 INFO - ##### 03:15:06 INFO - Running pre-action listener: _resource_record_pre_action 03:15:06 INFO - Running main action method: clobber 03:15:06 INFO - rmtree: /builds/slave/test/build 03:15:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:15:07 INFO - Running post-action listener: _resource_record_post_action 03:15:07 INFO - ##### 03:15:07 INFO - ##### Running read-buildbot-config step. 03:15:07 INFO - ##### 03:15:07 INFO - Running pre-action listener: _resource_record_pre_action 03:15:07 INFO - Running main action method: read_buildbot_config 03:15:07 INFO - Using buildbot properties: 03:15:07 INFO - { 03:15:07 INFO - "project": "", 03:15:07 INFO - "product": "firefox", 03:15:07 INFO - "script_repo_revision": "production", 03:15:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:15:07 INFO - "repository": "", 03:15:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:15:07 INFO - "buildid": "20160505123841", 03:15:07 INFO - "pgo_build": "True", 03:15:07 INFO - "basedir": "/builds/slave/test", 03:15:07 INFO - "buildnumber": 249, 03:15:07 INFO - "slavename": "talos-linux64-ix-017", 03:15:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:15:07 INFO - "platform": "ubuntu64_hw", 03:15:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:15:07 INFO - "branch": "mozilla-aurora", 03:15:07 INFO - "repo_path": "releases/mozilla-aurora", 03:15:07 INFO - "revision": "0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b", 03:15:07 INFO - "stage_platform": "linux64-pgo", 03:15:07 INFO - "builduid": "1457772db7ef4c1982b4796b67a4914d", 03:15:07 INFO - "slavebuilddir": "test" 03:15:07 INFO - } 03:15:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:15:07 INFO - Running post-action listener: _resource_record_post_action 03:15:07 INFO - ##### 03:15:07 INFO - ##### Running download-and-extract step. 03:15:07 INFO - ##### 03:15:07 INFO - Running pre-action listener: _resource_record_pre_action 03:15:07 INFO - Running main action method: download_and_extract 03:15:07 INFO - mkdir: /builds/slave/test/build/tests 03:15: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')]} 03:15:07 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:15:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:15:13 INFO - Downloaded 1361 bytes. 03:15:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:13 INFO - Using the following test package requirements: 03:15:13 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:15:13 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:15:13 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:15:13 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:13 INFO - u'jsshell-linux-x86_64.zip'], 03:15:13 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:15:13 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:15:13 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:15:13 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:15:13 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:15:13 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:15:13 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:15: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')]} 03:15:13 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:15:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:15:37 INFO - Downloaded 23824026 bytes. 03:15:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:15:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:15:38 INFO - Return code: 0 03:15:38 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:38 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:15:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:15:50 INFO - Downloaded 23824026 bytes. 03:15:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:15:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:15:52 INFO - Return code: 0 03:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:52 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:15:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:15:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:15:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:15:53 INFO - Downloaded 10840145 bytes. 03:15:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:15:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:15:53 INFO - Return code: 0 03:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:53 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:15:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:15:54 INFO - Downloaded 62687148 bytes. 03:15:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:54 INFO - mkdir: /builds/slave/test/properties 03:15:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:54 INFO - Contents: 03:15:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:55 INFO - Running post-action listener: _resource_record_post_action 03:15:55 INFO - Running post-action listener: set_extra_try_arguments 03:15:55 INFO - ##### 03:15:55 INFO - ##### Running populate-webroot step. 03:15:55 INFO - ##### 03:15:55 INFO - Running pre-action listener: _resource_record_pre_action 03:15:55 INFO - Running main action method: populate_webroot 03:15:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:15:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:15:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:15:55 INFO - '--tppagecycles', 03:15:55 INFO - '7'], 03:15:55 INFO - 'tests': ['tsvgm']}}, 03:15:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:15:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:15:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:15:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:15:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:15:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:15:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:55 INFO - 'talos_options': ['--disable-e10s'], 03:15:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:55 INFO - 'talos_options': ['--disable-e10s'], 03:15:55 INFO - 'tests': ['damp', 'tps']}, 03:15:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:55 INFO - 'tests': ['damp', 'tps']}, 03:15:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:15:55 INFO - 'tests': ['dromaeo_dom']}, 03:15:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:15:55 INFO - 'tests': ['a11yr', 03:15:55 INFO - 'ts_paint', 03:15:55 INFO - 'tpaint', 03:15:55 INFO - 'sessionrestore', 03:15:55 INFO - 'sessionrestore_no_auto_restore', 03:15:55 INFO - 'tabpaint']}, 03:15:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:15:55 INFO - 'ts_paint', 03:15:55 INFO - 'tpaint', 03:15:55 INFO - 'sessionrestore', 03:15:55 INFO - 'sessionrestore_no_auto_restore', 03:15:55 INFO - 'tabpaint']}, 03:15:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:15:55 INFO - 'ts_paint', 03:15:55 INFO - 'tpaint', 03:15:55 INFO - 'sessionrestore', 03:15:55 INFO - 'sessionrestore_no_auto_restore', 03:15:55 INFO - 'tabpaint']}, 03:15:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:15:55 INFO - 'ts_paint', 03:15:55 INFO - 'tpaint', 03:15:55 INFO - 'sessionrestore', 03:15:55 INFO - 'sessionrestore_no_auto_restore', 03:15:55 INFO - 'tabpaint']}, 03:15:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:15:55 INFO - 'tests': ['a11yr', 03:15:55 INFO - 'ts_paint', 03:15:55 INFO - 'tpaint', 03:15:55 INFO - 'sessionrestore', 03:15:55 INFO - 'sessionrestore_no_auto_restore', 03:15:55 INFO - 'tabpaint']}, 03:15:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:15:55 INFO - 'tests': ['a11yr', 03:15:55 INFO - 'ts_paint', 03:15:55 INFO - 'tpaint', 03:15:55 INFO - 'sessionrestore', 03:15:55 INFO - 'sessionrestore_no_auto_restore', 03:15:55 INFO - 'tabpaint']}, 03:15:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:15:55 INFO - 'tests': ['tsvgx', 03:15:55 INFO - 'tsvgr_opacity', 03:15:55 INFO - 'tart', 03:15:55 INFO - 'tscrollx', 03:15:55 INFO - 'cart']}, 03:15:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:15:55 INFO - 'tsvgr_opacity', 03:15:55 INFO - 'tart', 03:15:55 INFO - 'tscrollx', 03:15:55 INFO - 'cart']}, 03:15:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:55 INFO - 'talos_options': ['--disable-e10s'], 03:15:55 INFO - 'tests': ['tp5o']}, 03:15:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:55 INFO - 'tests': ['tp5o']}, 03:15:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:55 INFO - 'talos_options': ['--disable-e10s', 03:15:55 INFO - '--xperf_path', 03:15:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:55 INFO - 'tests': ['tp5n']}, 03:15:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:55 INFO - 'talos_options': ['--xperf_path', 03:15:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:55 INFO - 'tests': ['tp5n']}}, 03:15:55 INFO - 'talos.zip': {'path': '', 03:15:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:15:55 INFO - Running post-action listener: _resource_record_post_action 03:15:55 INFO - ##### 03:15:55 INFO - ##### Running create-virtualenv step. 03:15:55 INFO - ##### 03:15:55 INFO - Running pre-action listener: _resource_record_pre_action 03:15:55 INFO - Running main action method: create_virtualenv 03:15:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:15:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:15:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:55 INFO - Using real prefix '/usr' 03:15:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:58 INFO - Installing pip.................done. 03:15:58 INFO - Return code: 0 03:15:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:58 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 0x7f7cb5505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f410>, '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 0x2430310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24307a0>, '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': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:15:58 INFO - Using env: {'DISPLAY': ':0', 03:15:58 INFO - 'HOME': '/home/cltbld', 03:15:58 INFO - 'LANG': 'en_US.UTF-8', 03:15:58 INFO - 'LANGUAGE': 'en_US:en', 03:15:58 INFO - 'LOGNAME': 'cltbld', 03:15:58 INFO - 'MAIL': '/var/mail/cltbld', 03:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:58 INFO - 'MOZ_NO_REMOTE': '1', 03:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:58 INFO - 'NO_EM_RESTART': '1', 03:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:58 INFO - 'PWD': '/builds/slave/test', 03:15:58 INFO - 'SHELL': '/bin/bash', 03:15:58 INFO - 'SHLVL': '1', 03:15:58 INFO - 'TERM': 'linux', 03:15:58 INFO - 'TMOUT': '86400', 03:15:58 INFO - 'USER': 'cltbld', 03:15:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 03:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:58 INFO - '_': '/tools/buildbot/bin/python'} 03:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:15:58 INFO - Cleaning up... 03:15:58 INFO - Return code: 0 03:15:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:58 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 0x7f7cb5505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f410>, '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 0x2430310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24307a0>, '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': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:15:58 INFO - Using env: {'DISPLAY': ':0', 03:15:58 INFO - 'HOME': '/home/cltbld', 03:15:58 INFO - 'LANG': 'en_US.UTF-8', 03:15:58 INFO - 'LANGUAGE': 'en_US:en', 03:15:58 INFO - 'LOGNAME': 'cltbld', 03:15:58 INFO - 'MAIL': '/var/mail/cltbld', 03:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:58 INFO - 'MOZ_NO_REMOTE': '1', 03:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:58 INFO - 'NO_EM_RESTART': '1', 03:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:58 INFO - 'PWD': '/builds/slave/test', 03:15:58 INFO - 'SHELL': '/bin/bash', 03:15:58 INFO - 'SHLVL': '1', 03:15:58 INFO - 'TERM': 'linux', 03:15:58 INFO - 'TMOUT': '86400', 03:15:58 INFO - 'USER': 'cltbld', 03:15:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 03:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:58 INFO - '_': '/tools/buildbot/bin/python'} 03:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:58 INFO - Downloading/unpacking psutil>=0.7.1 03:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:00 INFO - Installing collected packages: psutil 03:16:00 INFO - Running setup.py install for psutil 03:16:00 INFO - building 'psutil._psutil_linux' extension 03:16:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:16:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:16:00 INFO - building 'psutil._psutil_posix' extension 03:16:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:16:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:16:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:01 INFO - Successfully installed psutil 03:16:01 INFO - Cleaning up... 03:16:01 INFO - Return code: 0 03:16:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:01 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 0x7f7cb5505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f410>, '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 0x2430310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24307a0>, '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': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:16:01 INFO - Using env: {'DISPLAY': ':0', 03:16:01 INFO - 'HOME': '/home/cltbld', 03:16:01 INFO - 'LANG': 'en_US.UTF-8', 03:16:01 INFO - 'LANGUAGE': 'en_US:en', 03:16:01 INFO - 'LOGNAME': 'cltbld', 03:16:01 INFO - 'MAIL': '/var/mail/cltbld', 03:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:01 INFO - 'MOZ_NO_REMOTE': '1', 03:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:01 INFO - 'NO_EM_RESTART': '1', 03:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:01 INFO - 'PWD': '/builds/slave/test', 03:16:01 INFO - 'SHELL': '/bin/bash', 03:16:01 INFO - 'SHLVL': '1', 03:16:01 INFO - 'TERM': 'linux', 03:16:01 INFO - 'TMOUT': '86400', 03:16:01 INFO - 'USER': 'cltbld', 03:16:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 03:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:01 INFO - '_': '/tools/buildbot/bin/python'} 03:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:16:03 INFO - Installing collected packages: mozsystemmonitor 03:16:03 INFO - Running setup.py install for mozsystemmonitor 03:16:03 INFO - Successfully installed mozsystemmonitor 03:16:03 INFO - Cleaning up... 03:16:03 INFO - Return code: 0 03:16:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7cb5505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f410>, '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 0x2430310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24307a0>, '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': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:16:03 INFO - Using env: {'DISPLAY': ':0', 03:16:03 INFO - 'HOME': '/home/cltbld', 03:16:03 INFO - 'LANG': 'en_US.UTF-8', 03:16:03 INFO - 'LANGUAGE': 'en_US:en', 03:16:03 INFO - 'LOGNAME': 'cltbld', 03:16:03 INFO - 'MAIL': '/var/mail/cltbld', 03:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:03 INFO - 'MOZ_NO_REMOTE': '1', 03:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:03 INFO - 'NO_EM_RESTART': '1', 03:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:03 INFO - 'PWD': '/builds/slave/test', 03:16:03 INFO - 'SHELL': '/bin/bash', 03:16:03 INFO - 'SHLVL': '1', 03:16:03 INFO - 'TERM': 'linux', 03:16:03 INFO - 'TMOUT': '86400', 03:16:03 INFO - 'USER': 'cltbld', 03:16:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 03:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:03 INFO - '_': '/tools/buildbot/bin/python'} 03:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:16:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:06 INFO - Downloading docopt-0.6.1.tar.gz 03:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:06 INFO - Running setup.py install for blobuploader 03:16:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:16:06 INFO - Running setup.py install for requests 03:16:06 INFO - Running setup.py install for docopt 03:16:06 INFO - Successfully installed blobuploader requests docopt 03:16:06 INFO - Cleaning up... 03:16:06 INFO - Return code: 0 03:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16: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')]} 03:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:06 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 0x7f7cb5505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f410>, '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 0x2430310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24307a0>, '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': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:16:06 INFO - Using env: {'DISPLAY': ':0', 03:16:06 INFO - 'HOME': '/home/cltbld', 03:16:06 INFO - 'LANG': 'en_US.UTF-8', 03:16:06 INFO - 'LANGUAGE': 'en_US:en', 03:16:06 INFO - 'LOGNAME': 'cltbld', 03:16:06 INFO - 'MAIL': '/var/mail/cltbld', 03:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:06 INFO - 'MOZ_NO_REMOTE': '1', 03:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:06 INFO - 'NO_EM_RESTART': '1', 03:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:06 INFO - 'PWD': '/builds/slave/test', 03:16:06 INFO - 'SHELL': '/bin/bash', 03:16:06 INFO - 'SHLVL': '1', 03:16:06 INFO - 'TERM': 'linux', 03:16:06 INFO - 'TMOUT': '86400', 03:16:06 INFO - 'USER': 'cltbld', 03:16:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 03:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:06 INFO - '_': '/tools/buildbot/bin/python'} 03:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:07 INFO - Running setup.py (path:/tmp/pip-YIqV_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:07 INFO - Running setup.py (path:/tmp/pip-OQc8Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:07 INFO - Running setup.py (path:/tmp/pip-bYpC1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:07 INFO - Running setup.py (path:/tmp/pip-GXiysy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:07 INFO - Running setup.py (path:/tmp/pip-FGzSTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:07 INFO - Running setup.py (path:/tmp/pip-88AFzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:07 INFO - Running setup.py (path:/tmp/pip-CLYMIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:07 INFO - Running setup.py (path:/tmp/pip-c2Z6nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:07 INFO - Running setup.py (path:/tmp/pip-x2pjdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:07 INFO - Running setup.py (path:/tmp/pip-OwCvAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:07 INFO - Running setup.py (path:/tmp/pip-k1cMUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:07 INFO - Running setup.py (path:/tmp/pip-gxuP75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:08 INFO - Running setup.py (path:/tmp/pip-sLmajO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:08 INFO - Running setup.py (path:/tmp/pip-03MLZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:08 INFO - Running setup.py (path:/tmp/pip-Cryr9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:08 INFO - Running setup.py (path:/tmp/pip-XQIhT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:08 INFO - Running setup.py (path:/tmp/pip-mGAT8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:08 INFO - Running setup.py install for manifestparser 03:16:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Running setup.py install for mozcrash 03:16:08 INFO - Running setup.py install for mozdebug 03:16:08 INFO - Running setup.py install for mozdevice 03:16:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Running setup.py install for mozfile 03:16:08 INFO - Running setup.py install for mozhttpd 03:16:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Running setup.py install for mozinfo 03:16:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Running setup.py install for mozInstall 03:16:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Running setup.py install for mozleak 03:16:09 INFO - Running setup.py install for mozlog 03:16:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Running setup.py install for moznetwork 03:16:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Running setup.py install for mozprocess 03:16:09 INFO - Running setup.py install for mozprofile 03:16:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Running setup.py install for mozrunner 03:16:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Running setup.py install for mozscreenshot 03:16:09 INFO - Running setup.py install for moztest 03:16:10 INFO - Running setup.py install for mozversion 03:16:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:16:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:10 INFO - Cleaning up... 03:16:10 INFO - Return code: 0 03:16:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16: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')]} 03:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:10 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 0x7f7cb5505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f410>, '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 0x2430310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24307a0>, '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': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:16:10 INFO - Using env: {'DISPLAY': ':0', 03:16:10 INFO - 'HOME': '/home/cltbld', 03:16:10 INFO - 'LANG': 'en_US.UTF-8', 03:16:10 INFO - 'LANGUAGE': 'en_US:en', 03:16:10 INFO - 'LOGNAME': 'cltbld', 03:16:10 INFO - 'MAIL': '/var/mail/cltbld', 03:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:10 INFO - 'MOZ_NO_REMOTE': '1', 03:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:10 INFO - 'NO_EM_RESTART': '1', 03:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:10 INFO - 'PWD': '/builds/slave/test', 03:16:10 INFO - 'SHELL': '/bin/bash', 03:16:10 INFO - 'SHLVL': '1', 03:16:10 INFO - 'TERM': 'linux', 03:16:10 INFO - 'TMOUT': '86400', 03:16:10 INFO - 'USER': 'cltbld', 03:16:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 03:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:10 INFO - '_': '/tools/buildbot/bin/python'} 03:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:10 INFO - Running setup.py (path:/tmp/pip-lZz1Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:10 INFO - Running setup.py (path:/tmp/pip-PM8d0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:10 INFO - Running setup.py (path:/tmp/pip-dtLvBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:10 INFO - Running setup.py (path:/tmp/pip-xOfp0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:10 INFO - Running setup.py (path:/tmp/pip-FgM3B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:10 INFO - Running setup.py (path:/tmp/pip-MBQAMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:10 INFO - Running setup.py (path:/tmp/pip-GsYIgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:10 INFO - Running setup.py (path:/tmp/pip-inzGX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:10 INFO - Running setup.py (path:/tmp/pip-nfIg_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:11 INFO - Running setup.py (path:/tmp/pip-f2T912-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:11 INFO - Running setup.py (path:/tmp/pip-pGvAjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:11 INFO - Running setup.py (path:/tmp/pip-r6j21M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:11 INFO - Running setup.py (path:/tmp/pip-ekXpqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:11 INFO - Running setup.py (path:/tmp/pip-94I8Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:11 INFO - Running setup.py (path:/tmp/pip-XpsErc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:11 INFO - Running setup.py (path:/tmp/pip-E8ybE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:11 INFO - Running setup.py (path:/tmp/pip-KJRX8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:13 INFO - Downloading blessings-1.6.tar.gz 03:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:13 INFO - Installing collected packages: blessings 03:16:13 INFO - Running setup.py install for blessings 03:16:13 INFO - Successfully installed blessings 03:16:13 INFO - Cleaning up... 03:16:13 INFO - Return code: 0 03:16:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:16:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:13 INFO - Reading from file tmpfile_stdout 03:16:13 INFO - Current package versions: 03:16:13 INFO - argparse == 1.2.1 03:16:13 INFO - blessings == 1.6 03:16:13 INFO - blobuploader == 1.2.4 03:16:13 INFO - docopt == 0.6.1 03:16:13 INFO - manifestparser == 1.1 03:16:13 INFO - mozInstall == 1.12 03:16:13 INFO - mozcrash == 0.17 03:16:13 INFO - mozdebug == 0.1 03:16:13 INFO - mozdevice == 0.48 03:16:13 INFO - mozfile == 1.2 03:16:13 INFO - mozhttpd == 0.7 03:16:13 INFO - mozinfo == 0.9 03:16:13 INFO - mozleak == 0.1 03:16:13 INFO - mozlog == 3.1 03:16:13 INFO - moznetwork == 0.27 03:16:13 INFO - mozprocess == 0.22 03:16:13 INFO - mozprofile == 0.28 03:16:13 INFO - mozrunner == 6.11 03:16:13 INFO - mozscreenshot == 0.1 03:16:13 INFO - mozsystemmonitor == 0.0 03:16:13 INFO - moztest == 0.7 03:16:13 INFO - mozversion == 1.4 03:16:13 INFO - psutil == 3.1.1 03:16:13 INFO - requests == 1.2.3 03:16:13 INFO - wsgiref == 0.1.2 03:16:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16: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')]} 03:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:13 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 0x7f7cb5505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f410>, '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 0x2430310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24307a0>, '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': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:16:13 INFO - Using env: {'DISPLAY': ':0', 03:16:13 INFO - 'HOME': '/home/cltbld', 03:16:13 INFO - 'LANG': 'en_US.UTF-8', 03:16:13 INFO - 'LANGUAGE': 'en_US:en', 03:16:13 INFO - 'LOGNAME': 'cltbld', 03:16:13 INFO - 'MAIL': '/var/mail/cltbld', 03:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:13 INFO - 'MOZ_NO_REMOTE': '1', 03:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:13 INFO - 'NO_EM_RESTART': '1', 03:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:13 INFO - 'PWD': '/builds/slave/test', 03:16:13 INFO - 'SHELL': '/bin/bash', 03:16:13 INFO - 'SHLVL': '1', 03:16:13 INFO - 'TERM': 'linux', 03:16:13 INFO - 'TMOUT': '86400', 03:16:13 INFO - 'USER': 'cltbld', 03:16:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 03:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:13 INFO - '_': '/tools/buildbot/bin/python'} 03:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:16:14 INFO - Cleaning up... 03:16:14 INFO - Return code: 0 03:16:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:14 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 0x7f7cb5505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f410>, '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 0x2430310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24307a0>, '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': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:16:14 INFO - Using env: {'DISPLAY': ':0', 03:16:14 INFO - 'HOME': '/home/cltbld', 03:16:14 INFO - 'LANG': 'en_US.UTF-8', 03:16:14 INFO - 'LANGUAGE': 'en_US:en', 03:16:14 INFO - 'LOGNAME': 'cltbld', 03:16:14 INFO - 'MAIL': '/var/mail/cltbld', 03:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:14 INFO - 'MOZ_NO_REMOTE': '1', 03:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:14 INFO - 'NO_EM_RESTART': '1', 03:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:14 INFO - 'PWD': '/builds/slave/test', 03:16:14 INFO - 'SHELL': '/bin/bash', 03:16:14 INFO - 'SHLVL': '1', 03:16:14 INFO - 'TERM': 'linux', 03:16:14 INFO - 'TMOUT': '86400', 03:16:14 INFO - 'USER': 'cltbld', 03:16:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 03:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:14 INFO - '_': '/tools/buildbot/bin/python'} 03:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:14 INFO - Downloading/unpacking jsonschema 03:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:16:16 INFO - Downloading/unpacking functools32 (from jsonschema) 03:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:16:16 INFO - warning: no files found matching '*.txt' 03:16:16 INFO - no previously-included directories found matching 'build' 03:16:16 INFO - no previously-included directories found matching 'dist' 03:16:16 INFO - no previously-included directories found matching '.git*' 03:16:16 INFO - Installing collected packages: jsonschema, functools32 03:16:16 INFO - Running setup.py install for functools32 03:16:16 INFO - warning: no files found matching '*.txt' 03:16:16 INFO - no previously-included directories found matching 'build' 03:16:16 INFO - no previously-included directories found matching 'dist' 03:16:16 INFO - no previously-included directories found matching '.git*' 03:16:16 INFO - Successfully installed jsonschema functools32 03:16:16 INFO - Cleaning up... 03:16:16 INFO - Return code: 0 03:16:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cb5505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f410>, '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 0x2430310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24307a0>, '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': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:16:16 INFO - Using env: {'DISPLAY': ':0', 03:16:16 INFO - 'HOME': '/home/cltbld', 03:16:16 INFO - 'LANG': 'en_US.UTF-8', 03:16:16 INFO - 'LANGUAGE': 'en_US:en', 03:16:16 INFO - 'LOGNAME': 'cltbld', 03:16:16 INFO - 'MAIL': '/var/mail/cltbld', 03:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:16 INFO - 'MOZ_NO_REMOTE': '1', 03:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:16 INFO - 'NO_EM_RESTART': '1', 03:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:16 INFO - 'PWD': '/builds/slave/test', 03:16:16 INFO - 'SHELL': '/bin/bash', 03:16:16 INFO - 'SHLVL': '1', 03:16:16 INFO - 'TERM': 'linux', 03:16:16 INFO - 'TMOUT': '86400', 03:16:16 INFO - 'USER': 'cltbld', 03:16:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 03:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:16 INFO - '_': '/tools/buildbot/bin/python'} 03:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:17 INFO - Downloading/unpacking flake8 03:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:16:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:16:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:16:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:16:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:16:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:16:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:16:19 INFO - no previously-included directories found matching 'docs/_build' 03:16:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:16:19 INFO - Running setup.py install for pep8 03:16:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:16:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:16:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:16:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:16:19 INFO - no previously-included directories found matching 'docs/_build' 03:16:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:16:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:16:19 INFO - Cleaning up... 03:16:19 INFO - Return code: 0 03:16:19 INFO - Running post-action listener: _resource_record_post_action 03:16:19 INFO - Running post-action listener: _start_resource_monitoring 03:16:19 INFO - Starting resource monitoring. 03:16:19 INFO - ##### 03:16:19 INFO - ##### Running install step. 03:16:19 INFO - ##### 03:16:19 INFO - Running pre-action listener: _resource_record_pre_action 03:16:19 INFO - Running main action method: install 03:16:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:20 INFO - Reading from file tmpfile_stdout 03:16:20 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:16:20 INFO - Reading from file tmpfile_stdout 03:16:20 INFO - Output received: 03:16:20 INFO - Usage: mozinstall [options] installer 03:16:20 INFO - Options: 03:16:20 INFO - -h, --help show this help message and exit 03:16:20 INFO - -d DEST, --destination=DEST 03:16:20 INFO - Directory to install application into. [default: 03:16:20 INFO - "/builds/slave/test"] 03:16:20 INFO - --app=APP Application being installed. [default: firefox] 03:16:20 INFO - mkdir: /builds/slave/test/build/application 03:16:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:16:35 INFO - Reading from file tmpfile_stdout 03:16:35 INFO - Output received: 03:16:35 INFO - /builds/slave/test/build/application/firefox/firefox 03:16:35 INFO - Running post-action listener: _resource_record_post_action 03:16:35 INFO - ##### 03:16:35 INFO - ##### Running run-tests step. 03:16:35 INFO - ##### 03:16:35 INFO - Running pre-action listener: _resource_record_pre_action 03:16:35 INFO - Running main action method: run_tests 03:16:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:35 INFO - Python 2.7.3 03:16:35 INFO - Return code: 0 03:16:35 INFO - grabbing minidump binary from tooltool 03:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:35 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 0x242f410>, '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 0x2430310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24307a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:16:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:16:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:35 INFO - Return code: 0 03:16:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:16:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:16:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:16:36 INFO - Return code: 0 03:16:36 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/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 03:16:36 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/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 03:16:36 INFO - Using env: {'DISPLAY': ':0', 03:16:36 INFO - 'HOME': '/home/cltbld', 03:16:36 INFO - 'LANG': 'en_US.UTF-8', 03:16:36 INFO - 'LANGUAGE': 'en_US:en', 03:16:36 INFO - 'LOGNAME': 'cltbld', 03:16:36 INFO - 'MAIL': '/var/mail/cltbld', 03:16:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:36 INFO - 'MOZ_NO_REMOTE': '1', 03:16:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:36 INFO - 'NO_EM_RESTART': '1', 03:16:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:36 INFO - 'PWD': '/builds/slave/test', 03:16:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:36 INFO - 'SHELL': '/bin/bash', 03:16:36 INFO - 'SHLVL': '1', 03:16:36 INFO - 'TERM': 'linux', 03:16:36 INFO - 'TMOUT': '86400', 03:16:36 INFO - 'USER': 'cltbld', 03:16:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691', 03:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:36 INFO - '_': '/tools/buildbot/bin/python'} 03:16:36 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/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 03:16:36 INFO - mozversion application_buildid: 20160505123841 03:16:36 INFO - mozversion application_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:16:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:16:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:36 INFO - mozversion application_name: Firefox 03:16:36 INFO - mozversion application_remotingname: firefox-dev 03:16:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:36 INFO - mozversion application_vendor: Mozilla 03:16:36 INFO - mozversion application_version: 48.0a2 03:16:36 INFO - mozversion platform_buildid: 20160505123841 03:16:36 INFO - mozversion platform_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:16:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:36 INFO - mozversion platform_version: 48.0a2 03:16:36 INFO - using testdate: 1462529796 03:16:36 INFO - actual date: 1462529796 03:16:36 INFO - starting webserver on 'localhost:46989' 03:16:36 INFO - SUITE-START | Running 2 tests 03:16:36 INFO - TEST-START | dromaeo_css 03:16:36 INFO - operating with platform_type : linux_ 03:16:36 INFO - Initialising browser for dromaeo_css test... 03:16:36 INFO - TEST-INFO | started process 24660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd1c3Yh/profile http://localhost:46989/getInfo.html) 03:16:40 INFO - PROCESS | 24660 | 03:16:40 INFO - PROCESS | 24660 | (process:24738): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:16:41 INFO - PROCESS | 24660 | __metrics Screen width/height:1600/1200 03:16:41 INFO - PROCESS | 24660 | colorDepth:24 03:16:41 INFO - PROCESS | 24660 | Browser inner width/height: 1024/697 03:16:41 INFO - PROCESS | 24660 | __metrics 03:16:41 ERROR - PROCESS | 24660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:16:42 INFO - TEST-INFO | 24660: exit 0 03:16:42 INFO - Browser initialized. 03:16:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:42 INFO - TEST-INFO | started process 24789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd1c3Yh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:44 INFO - PROCESS | 24789 | 03:16:44 INFO - PROCESS | 24789 | (process:24857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:16:54 INFO - PROCESS | 24789 | RSS: Main: 152190976 03:16:54 INFO - PROCESS | 24789 | 03:17:43 INFO - PROCESS | 24789 | 1462529863815 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:19:51 INFO - PROCESS | 24789 | Cycle 1(1): loaded http://localhost:46989/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46989/tests/dromaeo/cssquery-ext.html) 03:19:52 INFO - PROCESS | 24789 | RSS: Main: 155701248 03:19:52 INFO - PROCESS | 24789 | 03:22:54 INFO - PROCESS | 24789 | Cycle 1(1): loaded http://localhost:46989/tests/dromaeo/cssquery-ext.html (next: http://localhost:46989/tests/dromaeo/cssquery-jquery.html) 03:22:54 INFO - PROCESS | 24789 | RSS: Main: 154120192 03:22:54 INFO - PROCESS | 24789 | 03:25:56 INFO - PROCESS | 24789 | Cycle 1(1): loaded http://localhost:46989/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46989/tests/dromaeo/cssquery-mootools.html) 03:25:57 INFO - PROCESS | 24789 | RSS: Main: 153669632 03:25:57 INFO - PROCESS | 24789 | 03:28:58 INFO - PROCESS | 24789 | Cycle 1(1): loaded http://localhost:46989/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46989/tests/dromaeo/cssquery-prototype.html) 03:28:59 INFO - PROCESS | 24789 | RSS: Main: 153378816 03:28:59 INFO - PROCESS | 24789 | 03:32:01 INFO - PROCESS | 24789 | Cycle 1(1): loaded http://localhost:46989/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46989/tests/dromaeo/cssquery-yui.html) 03:32:02 INFO - PROCESS | 24789 | RSS: Main: 154976256 03:32:02 INFO - PROCESS | 24789 | 03:35:04 INFO - PROCESS | 24789 | Cycle 1(1): loaded http://localhost:46989/tests/dromaeo/cssquery-yui.html (next: http://localhost:46989/tests/dromaeo/cssquery-dojo.html) 03:35:04 INFO - PROCESS | 24789 | RSS: Main: 155865088 03:35:04 INFO - PROCESS | 24789 | 03:35:04 INFO - PROCESS | 24789 | __start_tp_report 03:35:04 INFO - PROCESS | 24789 | _x_x_mozilla_page_load 03:35:04 INFO - PROCESS | 24789 | _x_x_mozilla_page_load_details 03:35:04 INFO - PROCESS | 24789 | |i|pagename|runs| 03:35:04 INFO - PROCESS | 24789 | |0;dojo.html;3344.832758362081;3359.781614195078;3363.8149901755423;3408.4376077947154;3413.453847384419;5559.861003474915;5560.610757246995;5578.219049333092;5594.272744543208;5594.9720251398785;5536.723163841812;5550.47270509302;5568.777248910049;5597.524210442107;5615.045442274813;5069.391672999236;5134.358205224347;5141.537261646451;5154.046501397253;5172.534471897528;5007.123753343169;5147.897042059157;5268.288781014571;5277.208418737201;5302.098643230641;5119.078565858144;5158.303629010092;5172.586193104561;5286.154215325549;5302.363716354023;5162.535371816554;5192.376914770233;5199.688018718889;5212.921806172911;5214.5306922376785;5108.259302401131;5151.2273159026445;5162.045021671003;5210.76551555181;5243.947560524384;5431.592630552725;5447.673139611636;5518.144687573433;5566.914451681923;5584.022796010722;6035;6038.2150320458495;6044.395560443964;6067.544934129958;6070.3019152797115;6041.214642096544;6087.786927457518;6104.14541964121;6107.7556897724035;6109.633421994695;5471.753771080311;5553.500184983371;5634.492895639371;5635.351934527541;5653.604247702662;6095.238095238095;6103.023516237469;6110.388961103854;6125.816225513242;6129.049997250433;5707.486326230659;5880.911786323209;5891.293044834561;5906.793262235801;5917.733701983335;5782.2194003808945;5875.383084776123;5890.440408161217;5908.615939963888;5911.379305172895;5971.134185543072;5975.701214939236;5986.281646202484;5991.58058935879;6002.939970600325;5825.737841797045;5916.497097746654;5984.7606095756555;5989.730462129215;5990.071538911476;4533.954660453419;4603.148417542765;4605.355250264965;4606.239970404913;4634.235351167087;4115.053537686349;4125.360569111793;4126.174765047002;4140;4156.25187466259;5657.066584013674;5731.799387021518;5799.39106393831;5825.854353641193;5827.242458480455;5932.881342373128;5992.970035149797;6018.097285407224;6092.939070609325;6097.298810636745;5696.601237913389;5710.571707121982;5725.914111288334;5743.4256574342235;5764.798232061858;5060.342155519833;5118.360204974379;5130.461301563357;5144.331236939249;5175.81884634036;6158.568900176944;6182.381761823782;6192.287886892975;6223.875522489525;6246.031865060922;5945.078512830518;5967.19442875215;5999.1901093351835;6007.849803754766;6035.004224303117;6083.057126145454;6207.286162091236;6211.099390588249;6313.337099604475;6360.014197799349;5883.911741323798;5884.205632239593;5893.823185304448;5904;5916.763329466945;5960.642361458326;5968.045112781934;5968.731407086779;5990.550708696952;5994.550408719277;5737;5893.528517718658;5969.403059693996;5974.103884417372;6007.30915944672;5835.737391817293;5872.823815285548;5874.970625146847;5875.177475153568;5876.735546900314;5731.656100633975;5777.653340799566;5779.162021506942;5792.160136780059;5801.1878337032;5789.681567513827;5880.26496687914;5920.822375328747;5959.106134079922;6004.249468816398;5815.592908496534;5821.621594596338;5825.213596164633;5826.70866456684;5839.678817665069 03:35:04 INFO - PROCESS | 24789 | |1;ext.html;618.1901708761523;637.799093285615;652.928177900431;688.1260798785543;696.2654399608417;39101.608983910155;40302;40377.59622403775;40421.595784042154;40623.18753624926;43729.34405983905;44670.32994505085;44873.551264487345;44888.10223795522;44927.775361123146;8721.302295816351;8880.46717196967;8888.288936885034;8934.910650893473;8943.508107054142;8803;8920.46477211366;8925.687600933968;8933.15135062168;8938.195562399384;8852.026277109546;8877.245434138105;8878.334124940655;8878.378513504058;8955.820883582324;8849.646014159425;8889.155530224618;8903.777405564913;8908.777280567972;8930.062343453941;8740.825183496358;8784.956075219647;8837.469751814911;8878;8891.510966896818;40818.79590602028;41130.58869411297;41273;41317.58682413198;41561.58438415607;3773.8490460381554;4200.4959404871615;4320.82716691332;4483.4843992940905;4677.18149323867;33036.834815826005;33466.330673386394;33562.1609459763;33606.6639333606;34230.48654270188;4569.405977222973;4609.354690343354;4610.415424368926;4620.237660785966;4642.814287428499;323474;325030;326844.9999999976;329440;329606;54981.175282370794;55876.16185757136;56032.71983640056;56146;56218;61460;62664;62985.37014629795;63184;63428;18526.722099168255;18582.628347432976;18752;18772;18808.435746927615;14406.927965360315;14449.855501445061;14482.420703171965;14532.927335363256;14569;20500.38498845037;20567.794322056587;20939.37181884546;21449.57100857974;21483.57032859334;7547.8113047173165;7548.924510754932;7871.606419678993;7968.12350641429;8006.879896801553;1136.091127098318;1184.7867383870987;1185.5968970550055;1203.5377016924479;1216.1669256559107;32811.83594082014;33373.332533349196;33461.66538334634;33546.539474734454;33931.66068339285;1133.110508251019;1161.8024935760773;1184.8281999110081;1221.328269451798;1238.9814152787715;17567.560810979827;17608.295668173385;17802.643947120985;17838.46484605438;17840.55398615045;314693;319345;319729;446855;499003;62177.68911155415;64334.356656433774;64501;64534.35465645284;64603.67698161573;1524.2531159731652;1527.7402841516969;1533.325336851804;1540;1556.486359501362;32623.836880815445;33046.17384565405;33299.00102996914;33313.50029749507;34126;52539.737301313246;53213;53303.200451992474;53320.46679533155;53385;518708;521866;522663;522688;524975;30784.076477705705;31173.376532469676;31516.842415787774;31530.527042093927;31712.36575268528;48718.75640621774;48784.26823597578;48841.51158488512;49654;50154;41740.58259417367;41991.7900410496;42047.15905681808;42261.78869105635;43023.78488107539;40556.1888762229;40905.79547102245;41641.58358416498;41834;42997.785011074746;42170.7891460553;42453.787731061144;42515.7874210627;42986.785066074466;43121.35317970296;35409;36636.26727465382;36766.44850327194;37338.8133059333;37525.249495010496;28446.57330140091;29301.26746831261;29325.560116598695;29333.55999659964;29702.851485742434 03:35:04 INFO - PROCESS | 24789 | |2;jquery.html;408.96523795477367;413.3242149086243;415.119945715084;416.5563674686459;425.2069889655793;18663.253469861207;19160.71258931117;19348.51628709283;19389.224431022743;20098;11793.882061179407;11997.520099196021;12173.391330433466;12254.754904901896;12374.381280935962;5204.609654275935;5312.814051508179;5318.654287471321;5319.0957537218765;5349.438308977559;5246.632735708502;5886.852828679274;5915.763369465216;5920.200772895647;5935.821925342247;5794.159846822208;5848.590598658096;5860.296764388258;5870.060790273557;5871.236739223917;5344.4922732340365;5624.578156638268;5630.296212973379;5630.493255607015;5652.010898092838;5400.864978375533;5494.038543254915;5695.829125126253;5748.051571490699;5757.107648314476;12996.740065198643;13028.348582570834;13125.86874131256;13128.01539884503;13756.518521851787;2293.3005433342823;2349.459624286407;2364.2907127861745;2374.1097088591778;2562.7821635161035;9856.260780441495;10003.499825008794;10243;10266.538005789758;10326.122279606243;1973.2797528901847;2001.549651328454;2018.3944816555122;2106.2838634864065;2170.3271985684487;80860.59569702172;81754;82557;84406;84799;10776.568937242579;10791;11428.428578571038;11480.425978701032;11481.655550333504;15825.050496970218;15907.204639767966;15923.283452244677;15930.920345398199;16016.119113448873;8448.112948140357;8466.068732439428;8602.010768761547;8607.569621518898;8625.0943650917;8243.546604936786;8330.8333833323;8411.789705257295;8422.494650321001;8550.444221125606;4616.815327386934;4669.766511674403;4728.345079222245;4753.025629745894;4938.654294199371;1896.5922326699826;2027.4221846773598;2054.815066644009;2067.7415323084615;2069.244725675118;961.8461046232569;1005.1355833982769;1055.4036969112426;1105.4583254205543;1119.5801574409597;18724.625507489774;19249.422517324503;19366.61266774685;19370.846875452353;19380.612387752168;1082.5723839083519;1083.47992963378;1119.9776004479866;1126.1980830670861;1161.1523587780798;10706.89293107059;11015.889841101647;11126.944365278121;11187.552497900155;11192.328460292245;403269;405958;406409;407288;555094;58786;61701.691491543155;62158.37841621526;100011;103860.48069759602;1108.7172770943519;1129.2546919033398;1150.6411855695958;1157.0107558037926;1159.5072094359864;17754.37859674905;17890.731639025686;18005.099745012958;18078.367257145936;18192.72710909311;40914.59085409227;41642.58357416387;42169;42635.23146699195;43348.56651433445;57947;58127;59335.40664593299;60167.699161503915;60892;8290.419670622998;8434.451760635538;8744.256738177326;8782.209601135928;8943.418677785923;12578.622641320775;13454.798178027142;13789.586312410644;14299.21354325522;14422.927885360506;12526.49894004266;12536.623901282976;12538.122331436713;12623.747525049264;12827.807582886451;12274.140810143204;12347.69130771738;12501.624951251477;12645.683857903257;12802;12428.751424971631;12650.810237846625;12791.936040319739;12842.357882106044;13041.152325098838;8899.15458031486;8908.777280568038;8970.192682658591;9042.321825863219;9071.863922041306;8896.332775041768;12495.875041249836;12525.123241373016;12677.936610316889;12798.87201128014 03:35:04 INFO - PROCESS | 24789 | |3;mootools.html;1610.2351383093032;1623.9594010149744;1836.614310994691;1905.1902941249966;1943.018775518363;7644.541327520353;8195.87706184407;8276.089630140696;8521.78695532612;8621.741347759562;8270.95864520678;8319.958400208006;8381.32949364051;8435.325173986083;8445.113263107378;2319.060780383947;2329.440934175794;2346.800521955627;2352.741198468167;2355.7762012608773;2309.0417476747216;2311.884405779713;2359.7994170495526;2365.1840115160244;2366.6095094309417;2331.3472227776165;2357.3281614739803;2372.323887692008;2393.7606239376096;2395.9161429349974;2267.807236384909;2291.9885400572975;2311.7803808638237;2315.0161181497797;2341.2976107167783;2296.632538793802;2298.2990187992655;2306.5386922615544;2311.3297143828268;2318.211807985276;8484.19400156984;8536.74389768308;8547.102554231778;8550.059493455716;8573.871391929126;5050.671706339113;5099.71951542665;5181.766820493087;5242.79028838846;5251.10731175701;3135.2064002556936;3162.857671404792;3171.920701982469;3239.400710868497;3261.771675982682;1045.1012129568564;1045.5608644369383;1052.2160990062375;1059.9788004239872;1096.7970925378831;11330.150238732129;11372.203945723802;11390.886091139066;11408.258463199865;11466.885331146665;4428.13651337986;4468.32975053738;4547.954520454819;4557.635389168859;4598.747068911175;9810.21518278536;9821.656242031495;9874.358166719141;9874.901250987541;9877.308588398742;5134.897302053938;5148;5154.61340399464;5197.272381866542;5205.557527610195;4268.061026574149;4697.365855609449;4726.95273047272;4815.133276010351;4889.413270407503;4033.193361327746;4092.1815636872743;4136.586341365839;4155.667546596265;4205;1265.3104058288254;1294.6633875192517;1301.9934900325438;1302.0625149892253;1316.8419789625307;983.1348413396308;1004.6182450668845;1024.8206563851445;1038.2939601071344;1039.0440794469107;5850;5982.611130276518;6019.729112189962;6063.423974722395;6189.50483961282;947.7489713578149;964.62379671928;1004.2016596805557;1017.4810846468355;1047.8847326794046;3851.2297540492013;3916.4516967624554;3916.5104361954754;3951.5258169019903;3974.066094467798;10211.183105351554;10600.416977066181;10650.946745266225;10732.87304832997;10779.461026948622;10459.163266938627;10572.36565806054;10650.840237396445;10655.786884262272;10659.093977011886;7883.172266912006;7983;8117.715879944291;8135.593220339078;8158.877616835753;5664.745086471036;5681.431856814285;5743.339515955551;5798.275215598051;5840.795572154954;9382.10869967352;9628.374155679858;9644.132028117223;9743.464109474047;9778.65774697882;9551.617935282511;9683.41899486033;9820.263480239153;9846.606135754777;9950.303478756417;6456.192975878015;7043.929560704328;7086.078809754699;7216.675249613885;7381.667824947783;8331.916680833356;8337.124601916712;8366.205210504992;8414.326853851555;8435.789105272417;7428.294312040348;7583.544987300559;7643.121041080347;7730.613469326398;7745.961270193613;7266.273372662691;7304.817379565553;7326.633668316669;7374.004509391378;7522.059742532184;7340.779776606711;7384.778456646309;7400.444966627632;7424.888626670712;7446.962765186356;5006.799728010985;5051.318072060225;5157.742112894415;5161.741912904415;5180.041692286939;4967.677100988424;5050.72221027847;5135.435102138837;5170.48295170495;5200.843974680765 03:35:04 INFO - PROCESS | 24789 | |4;prototype.html;319.7489970373256;326.90683155300735;333.0275595261836;333.6246722437258;333.92987472630745;5731.541476681866;5819.272590926134;5827.086456771614;5836.21211136497;5838.532917366617;5619.831405057845;5665.461781130786;5691.174779656947;5711.371749107595;5713.485786279244;4167.499700107959;4241.978790106045;4395.582419670142;4408.537103604123;4443.60007599316;4412.176207227361;4423.9603693132085;4427.535108813577;4427.712198707074;4433.401490798749;4370.912581748363;4398.516163222043;4404.515503294635;4417.73493590384;4429.269170586849;4338.869833904988;4368.563143685637;4380.846670366522;4398.8123206734;4402;3846.096182389707;3850.2876967761053;3852.499175107218;3856.8842934712;3877.5346958364894;5529.529989950859;5543.697231150676;5545.500904918536;5549.972250138723;5562.666240025571;4869.586085182764;5013.623978201613;5021.698698078127;5030;5062.721550314731;5961.837441698871;5973.581849270553;5986.401359864022;6025.096235564701;6027.794441111751;4246.473348357722;4251.893702657428;4253.3619957006695;4254.638355739766;4258.041940563379;6061.636301821904;6142.894279029772;6143.569950103494;6192.938070619326;6202.286737025254;4299;4310.741355518679;4328.761918094472;4338.783060846945;4348.499922508889;4377.212101821639;4380.386745855582;4396.1867054595;4396.450443694538;4399.120175964756;4901.240307752304;4950.8762280943265;4998.375203099613;5014.799408023711;5015.774290156952;5982.670953097534;6021.2473440819895;6044.818655440344;6051.636901785907;6061.696915154224;1566.6631674190103;1606.0604546340521;1610.0983449268213;1611.0011792688608;1611.653494498665;1009.7526106104051;1041.1202533858877;1071.539238127597;1077.342820879263;1078.3475997021847;6184.443400094013;6256.499480041586;6260.40526150015;6291.1192433059405;6293.527985401113;6535.3464653534265;6570.310117437696;6580.76967306142;6597.802065937934;6618.139641846529;5707.229524014288;5947.197128387612;5964.522838172936;6006.729697163638;6027.7890273841085;3543.167355671415;3576.7853928764357;3591.8865151803025;3595;3604.891853244407;6141.692915354214;6493.285738568754;6507.8698426031215;6517.771877984248;6955.817511023139;6350.190195794176;6419.165508483868;6419.967900160469;6440.54916155874;6467.741290348427;6370.299267080617;6491.740330386826;6536.215654121535;6536.477081833442;6538.444232240313;6250.624962502265;6276.466500347522;6282.497400207881;6287.182666253358;6326.746930122744;5949.315828679757;6150.507959363151;6170.92008898432;6184.938150618616;6199.442050215503;6513.436775173829;6546.934530654823;6556.967215163893;6578.76974305897;6622.503312251697;4277.144571085858;4328.978355108205;4330.41539392178;4345.435093437833;4363.956360436355;6248.375162483715;6335.936640633535;6336.778212762531;6354.332795056453;6382.234131904015;6136.2636483622255;6154.1999540059505;6161.568690191643;6181.629102253879;6208.689565521616;5933.554983376178;6091.7258723358445;6120.510359171345;6145.385461453819;6185.793770214765;5735.197072409783;5892.793752218652;5999.850003749942;6069.393060693896;6071.692756752406;6050.576459647782;6106.1451396803595;6171.56799024064;6172.783952561639;6196.535259855619;5654.858628534155;5993.130996005642;6031.155638210742;6046.609279865567;6053.697315134137 03:35:04 INFO - PROCESS | 24789 | |5;yui.html;881.7134431309823;894.5661552498734;900.5137225898011;904.6019751309424;923.7413524213214;14166.504172353969;14287.357068931897;14526.34631441585;14731.852681473169;14827.110373377605;14122.788158177636;14189.645258868533;14192.432302707904;14243.643908902282;14263.072900261503;762.1463960364372;773.1456740301942;907.4237858959575;916.5142474488532;916.9954150229239;910.4901255297054;911.2983003087619;912.4160537256162;918.6922381002372;919.2462181011573;946.4605175050224;953.4231789767196;953.5232383808096;956.4787190980932;956.4978386347188;935.6351023100996;938.7324612485477;940.5203346293406;942.4816351006988;944.8629948657441;690.3338278561213;695.7286658203304;696.3245651717825;696.4184905603777;701.4949236549676;14626.780598291034;14643.12141271527;14688.779668304984;14698.55904322872;14731.410743570244;14981;14991.700165996619;15079.396824127021;15177.620559485991;15218.619534511616;10786.244962852603;10830.945845270802;11023.118150547936;11316.434178291134;11714.53141874324;3885.067583779901;3893.6301051400073;3919.0790164311366;3923.097687531884;4060.979695101535;57421.712891435694;58096.41903580952;58444.41555584432;60289.39710602925;60837.69581152066;11352.716182095348;11504.25222360544;11567.826482602768;11671.299722016705;11752;19171.808281917;19727.40817775469;19728.506787330145;19834.107465164103;19906.90046549758;8628.22345988864;8718.43330183536;8877.983939074402;9100;9212.585433655502;4958.578520825698;4996.482745638121;5019.779696810459;5083.771230294646;5098.694078355311;3426.9657303427143;3452.913677158041;3459.8270086495572;3461.4115600348;3473.8089405082965;648.3063122459018;675.9763408280785;677.7492327838731;690.4441924251026;691.8339598496325;773.4083426178978;775.8168792591231;831.1750289568989;835.0688981785265;835.7200337886754;9634.951825240829;9679.66121185755;9740.366876153028;9802.068803463659;10060.295779295526;601.9414592130282;646.5377255262509;682.5051837417832;689.8689249042666;749.5877267502851;4058.4723985882238;4093.7953102344763;4108.075682971307;4132.669386449077;4142.834286628561;64062.67968660127;65266.347336526975;65518;66404;66588.6670566644;56750.43249567534;57093;58091;58829.117563236585;59665;50007.999840002994;50503.24245136326;50972.74513627408;51216.23175652368;51624.741876290376;8782.121787821166;9012.188902998761;9143.405678630868;9169.816603667756;9188.632454701738;30863;32445.02664920056;32485.35029299448;32974.17564560905;34256.143596410286;46167;47129;47145.764271179796;48003.5199647999;48509;11900.642980710592;12230.266184028987;12389.690257743629;12468.189567678071;12664.556740514037;13887.791683124964;13896.51362202318;14160.079594826304;14692.338844751797;14694.926525367304;11707.824382634097;11887.16789824704;12218.083643726579;13965.231912244924;14525.78211326852;13775.586732398044;13787.379567919668;13849.861501384858;13939.860601393857;14028.859711402756;12268.44791984345;12796.424160912595;12861.742765144832;13059.673508162372;13725.382357793724;11432.428378580871;11719.296842189497;11760.647180584596;11913.801135969541;12053.216540924812;10657.467126643482;11211.71970700739;11225.382603956534;11352.659420217407;11469.483873225892 03:35:04 INFO - PROCESS | 24789 | __end_tp_report 03:35:04 INFO - PROCESS | 24789 | __start_cc_report 03:35:04 INFO - PROCESS | 24789 | _x_x_mozilla_cycle_collect,348 03:35:04 INFO - PROCESS | 24789 | __end_cc_report 03:35:04 INFO - PROCESS | 24789 | __startTimestamp1462530904895__endTimestamp 03:35:04 INFO - PROCESS | 24789 | 03:35:04 INFO - PROCESS | 24789 | ------- Summary: start ------- 03:35:04 INFO - PROCESS | 24789 | Number of tests: 6 03:35:04 INFO - PROCESS | 24789 | 03:35:04 INFO - PROCESS | 24789 | [#0] dojo.html Cycles:165 Average:5588.86 Median:5815.59 stddev:607.95 (10.5%) stddev-sans-first:583.77 03:35:04 INFO - PROCESS | 24789 | Values: 3344.8 3359.8 3363.8 3408.4 3413.5 5559.9 5560.6 5578.2 5594.3 5595.0 5536.7 5550.5 5568.8 5597.5 5615.0 5069.4 5134.4 5141.5 5154.0 5172.5 5007.1 5147.9 5268.3 5277.2 5302.1 5119.1 5158.3 5172.6 5286.2 5302.4 5162.5 5192.4 5199.7 5212.9 5214.5 5108.3 5151.2 5162.0 5210.8 5243.9 5431.6 5447.7 5518.1 5566.9 5584.0 6035.0 6038.2 6044.4 6067.5 6070.3 6041.2 6087.8 6104.1 6107.8 6109.6 5471.8 5553.5 5634.5 5635.4 5653.6 6095.2 6103.0 6110.4 6125.8 6129.0 5707.5 5880.9 5891.3 5906.8 5917.7 5782.2 5875.4 5890.4 5908.6 5911.4 5971.1 5975.7 5986.3 5991.6 6002.9 5825.7 5916.5 5984.8 5989.7 5990.1 4534.0 4603.1 4605.4 4606.2 4634.2 4115.1 4125.4 4126.2 4140.0 4156.3 5657.1 5731.8 5799.4 5825.9 5827.2 5932.9 5993.0 6018.1 6092.9 6097.3 5696.6 5710.6 5725.9 5743.4 5764.8 5060.3 5118.4 5130.5 5144.3 5175.8 6158.6 6182.4 6192.3 6223.9 6246.0 5945.1 5967.2 5999.2 6007.8 6035.0 6083.1 6207.3 6211.1 6313.3 6360.0 5883.9 5884.2 5893.8 5904.0 5916.8 5960.6 5968.0 5968.7 5990.6 5994.6 5737.0 5893.5 5969.4 5974.1 6007.3 5835.7 5872.8 5875.0 5875.2 5876.7 5731.7 5777.7 5779.2 5792.2 5801.2 5789.7 5880.3 5920.8 5959.1 6004.2 5815.6 5821.6 5825.2 5826.7 5839.7 03:35:04 INFO - PROCESS | 24789 | 03:35:04 INFO - PROCESS | 24789 | [#1] ext.html Cycles:180 Average:58377.13 Median:23123.83 stddev:111193.17 (480.9%) stddev-sans-first:111420.53 03:35:04 INFO - PROCESS | 24789 | Values: 618.2 637.8 652.9 688.1 696.3 39101.6 40302.0 40377.6 40421.6 40623.2 43729.3 44670.3 44873.6 44888.1 44927.8 8721.3 8880.5 8888.3 8934.9 8943.5 8803.0 8920.5 8925.7 8933.2 8938.2 8852.0 8877.2 8878.3 8878.4 8955.8 8849.6 8889.2 8903.8 8908.8 8930.1 8740.8 8785.0 8837.5 8878.0 8891.5 40818.8 41130.6 41273.0 41317.6 41561.6 3773.8 4200.5 4320.8 4483.5 4677.2 33036.8 33466.3 33562.2 33606.7 34230.5 4569.4 4609.4 4610.4 4620.2 4642.8 323474.0 325030.0 326845.0 329440.0 329606.0 54981.2 55876.2 56032.7 56146.0 56218.0 61460.0 62664.0 62985.4 63184.0 63428.0 18526.7 18582.6 18752.0 18772.0 18808.4 14406.9 14449.9 14482.4 14532.9 14569.0 20500.4 20567.8 20939.4 21449.6 21483.6 7547.8 7548.9 7871.6 7968.1 8006.9 1136.1 1184.8 1185.6 1203.5 1216.2 32811.8 33373.3 33461.7 33546.5 33931.7 1133.1 1161.8 1184.8 1221.3 1239.0 17567.6 17608.3 17802.6 17838.5 17840.6 314693.0 319345.0 319729.0 446855.0 499003.0 62177.7 64334.4 64501.0 64534.4 64603.7 1524.3 1527.7 1533.3 1540.0 1556.5 32623.8 33046.2 33299.0 33313.5 34126.0 52539.7 53213.0 53303.2 53320.5 53385.0 518708.0 521866.0 522663.0 522688.0 524975.0 30784.1 31173.4 31516.8 31530.5 31712.4 48718.8 48784.3 48841.5 49654.0 50154.0 41740.6 41991.8 42047.2 42261.8 43023.8 40556.2 40905.8 41641.6 41834.0 42997.8 42170.8 42453.8 42515.8 42986.8 43121.4 35409.0 36636.3 36766.4 37338.8 37525.2 28446.6 29301.3 29325.6 29333.6 29702.9 03:35:04 INFO - PROCESS | 24789 | 03:35:04 INFO - PROCESS | 24789 | [#2] jquery.html Cycles:180 Average:26901.48 Median:2068.49 stddev:72681.31 (3513.7%) stddev-sans-first:72857.97 03:35:04 INFO - PROCESS | 24789 | Values: 409.0 413.3 415.1 416.6 425.2 18663.3 19160.7 19348.5 19389.2 20098.0 11793.9 11997.5 12173.4 12254.8 12374.4 5204.6 5312.8 5318.7 5319.1 5349.4 5246.6 5886.9 5915.8 5920.2 5935.8 5794.2 5848.6 5860.3 5870.1 5871.2 5344.5 5624.6 5630.3 5630.5 5652.0 5400.9 5494.0 5695.8 5748.1 5757.1 12996.7 13028.3 13125.9 13128.0 13756.5 2293.3 2349.5 2364.3 2374.1 2562.8 9856.3 10003.5 10243.0 10266.5 10326.1 1973.3 2001.5 2018.4 2106.3 2170.3 80860.6 81754.0 82557.0 84406.0 84799.0 10776.6 10791.0 11428.4 11480.4 11481.7 15825.1 15907.2 15923.3 15930.9 16016.1 8448.1 8466.1 8602.0 8607.6 8625.1 8243.5 8330.8 8411.8 8422.5 8550.4 4616.8 4669.8 4728.3 4753.0 4938.7 1896.6 2027.4 2054.8 2067.7 2069.2 961.8 1005.1 1055.4 1105.5 1119.6 18724.6 19249.4 19366.6 19370.8 19380.6 1082.6 1083.5 1120.0 1126.2 1161.2 10706.9 11015.9 11126.9 11187.6 11192.3 403269.0 405958.0 406409.0 407288.0 555094.0 58786.0 61701.7 62158.4 100011.0 103860.5 1108.7 1129.3 1150.6 1157.0 1159.5 17754.4 17890.7 18005.1 18078.4 18192.7 40914.6 41642.6 42169.0 42635.2 43348.6 57947.0 58127.0 59335.4 60167.7 60892.0 8290.4 8434.5 8744.3 8782.2 8943.4 12578.6 13454.8 13789.6 14299.2 14422.9 12526.5 12536.6 12538.1 12623.7 12827.8 12274.1 12347.7 12501.6 12645.7 12802.0 12428.8 12650.8 12791.9 12842.4 13041.2 8899.2 8908.8 8970.2 9042.3 9071.9 8896.3 12495.9 12525.1 12677.9 12798.9 03:35:04 INFO - PROCESS | 24789 | 03:35:04 INFO - PROCESS | 24789 | [#3] mootools.html Cycles:180 Average:5651.03 Median:5051.02 stddev:3119.26 (61.8%) stddev-sans-first:3113.23 03:35:04 INFO - PROCESS | 24789 | Values: 1610.2 1624.0 1836.6 1905.2 1943.0 7644.5 8195.9 8276.1 8521.8 8621.7 8271.0 8320.0 8381.3 8435.3 8445.1 2319.1 2329.4 2346.8 2352.7 2355.8 2309.0 2311.9 2359.8 2365.2 2366.6 2331.3 2357.3 2372.3 2393.8 2395.9 2267.8 2292.0 2311.8 2315.0 2341.3 2296.6 2298.3 2306.5 2311.3 2318.2 8484.2 8536.7 8547.1 8550.1 8573.9 5050.7 5099.7 5181.8 5242.8 5251.1 3135.2 3162.9 3171.9 3239.4 3261.8 1045.1 1045.6 1052.2 1060.0 1096.8 11330.2 11372.2 11390.9 11408.3 11466.9 4428.1 4468.3 4548.0 4557.6 4598.7 9810.2 9821.7 9874.4 9874.9 9877.3 5134.9 5148.0 5154.6 5197.3 5205.6 4268.1 4697.4 4727.0 4815.1 4889.4 4033.2 4092.2 4136.6 4155.7 4205.0 1265.3 1294.7 1302.0 1302.1 1316.8 983.1 1004.6 1024.8 1038.3 1039.0 5850.0 5982.6 6019.7 6063.4 6189.5 947.7 964.6 1004.2 1017.5 1047.9 3851.2 3916.5 3916.5 3951.5 3974.1 10211.2 10600.4 10650.9 10732.9 10779.5 10459.2 10572.4 10650.8 10655.8 10659.1 7883.2 7983.0 8117.7 8135.6 8158.9 5664.7 5681.4 5743.3 5798.3 5840.8 9382.1 9628.4 9644.1 9743.5 9778.7 9551.6 9683.4 9820.3 9846.6 9950.3 6456.2 7043.9 7086.1 7216.7 7381.7 8331.9 8337.1 8366.2 8414.3 8435.8 7428.3 7583.5 7643.1 7730.6 7746.0 7266.3 7304.8 7326.6 7374.0 7522.1 7340.8 7384.8 7400.4 7424.9 7447.0 5006.8 5051.3 5157.7 5161.7 5180.0 4967.7 5050.7 5135.4 5170.5 5200.8 03:35:04 INFO - PROCESS | 24789 | 03:35:04 INFO - PROCESS | 24789 | [#4] prototype.html Cycles:180 Average:5118.87 Median:5831.65 stddev:1535.53 (26.3%) stddev-sans-first:1496.99 03:35:04 INFO - PROCESS | 24789 | Values: 319.7 326.9 333.0 333.6 333.9 5731.5 5819.3 5827.1 5836.2 5838.5 5619.8 5665.5 5691.2 5711.4 5713.5 4167.5 4242.0 4395.6 4408.5 4443.6 4412.2 4424.0 4427.5 4427.7 4433.4 4370.9 4398.5 4404.5 4417.7 4429.3 4338.9 4368.6 4380.8 4398.8 4402.0 3846.1 3850.3 3852.5 3856.9 3877.5 5529.5 5543.7 5545.5 5550.0 5562.7 4869.6 5013.6 5021.7 5030.0 5062.7 5961.8 5973.6 5986.4 6025.1 6027.8 4246.5 4251.9 4253.4 4254.6 4258.0 6061.6 6142.9 6143.6 6192.9 6202.3 4299.0 4310.7 4328.8 4338.8 4348.5 4377.2 4380.4 4396.2 4396.5 4399.1 4901.2 4950.9 4998.4 5014.8 5015.8 5982.7 6021.2 6044.8 6051.6 6061.7 1566.7 1606.1 1610.1 1611.0 1611.7 1009.8 1041.1 1071.5 1077.3 1078.3 6184.4 6256.5 6260.4 6291.1 6293.5 6535.3 6570.3 6580.8 6597.8 6618.1 5707.2 5947.2 5964.5 6006.7 6027.8 3543.2 3576.8 3591.9 3595.0 3604.9 6141.7 6493.3 6507.9 6517.8 6955.8 6350.2 6419.2 6420.0 6440.5 6467.7 6370.3 6491.7 6536.2 6536.5 6538.4 6250.6 6276.5 6282.5 6287.2 6326.7 5949.3 6150.5 6170.9 6184.9 6199.4 6513.4 6546.9 6557.0 6578.8 6622.5 4277.1 4329.0 4330.4 4345.4 4364.0 6248.4 6335.9 6336.8 6354.3 6382.2 6136.3 6154.2 6161.6 6181.6 6208.7 5933.6 6091.7 6120.5 6145.4 6185.8 5735.2 5892.8 5999.9 6069.4 6071.7 6050.6 6106.1 6171.6 6172.8 6196.5 5654.9 5993.1 6031.2 6046.6 6053.7 03:35:04 INFO - PROCESS | 24789 | 03:35:04 INFO - PROCESS | 24789 | [#5] yui.html Cycles:180 Average:15425.69 Median:25154.92 stddev:17901.23 (71.2%) stddev-sans-first:17918.12 03:35:04 INFO - PROCESS | 24789 | Values: 881.7 894.6 900.5 904.6 923.7 14166.5 14287.4 14526.3 14731.9 14827.1 14122.8 14189.6 14192.4 14243.6 14263.1 762.1 773.1 907.4 916.5 917.0 910.5 911.3 912.4 918.7 919.2 946.5 953.4 953.5 956.5 956.5 935.6 938.7 940.5 942.5 944.9 690.3 695.7 696.3 696.4 701.5 14626.8 14643.1 14688.8 14698.6 14731.4 14981.0 14991.7 15079.4 15177.6 15218.6 10786.2 10830.9 11023.1 11316.4 11714.5 3885.1 3893.6 3919.1 3923.1 4061.0 57421.7 58096.4 58444.4 60289.4 60837.7 11352.7 11504.3 11567.8 11671.3 11752.0 19171.8 19727.4 19728.5 19834.1 19906.9 8628.2 8718.4 8878.0 9100.0 9212.6 4958.6 4996.5 5019.8 5083.8 5098.7 3427.0 3452.9 3459.8 3461.4 3473.8 648.3 676.0 677.7 690.4 691.8 773.4 775.8 831.2 835.1 835.7 9635.0 9679.7 9740.4 9802.1 10060.3 601.9 646.5 682.5 689.9 749.6 4058.5 4093.8 4108.1 4132.7 4142.8 64062.7 65266.3 65518.0 66404.0 66588.7 56750.4 57093.0 58091.0 58829.1 59665.0 50008.0 50503.2 50972.7 51216.2 51624.7 8782.1 9012.2 9143.4 9169.8 9188.6 30863.0 32445.0 32485.4 32974.2 34256.1 46167.0 47129.0 47145.8 48003.5 48509.0 11900.6 12230.3 12389.7 12468.2 12664.6 13887.8 13896.5 14160.1 14692.3 14694.9 11707.8 11887.2 12218.1 13965.2 14525.8 13775.6 13787.4 13849.9 13939.9 14028.9 12268.4 12796.4 12861.7 13059.7 13725.4 11432.4 11719.3 11760.6 11913.8 12053.2 10657.5 11211.7 11225.4 11352.7 11469.5 03:35:04 INFO - PROCESS | 24789 | -------- Summary: end -------- 03:35:04 INFO - PROCESS | 24789 | 03:35:05 INFO - TEST-INFO | 24789: exit 0 03:35:05 INFO - TEST-OK | dromaeo_css | took 1108592ms 03:35:05 INFO - TEST-START | kraken 03:35:05 INFO - operating with platform_type : linux_ 03:35:05 INFO - Initialising browser for kraken test... 03:35:05 INFO - TEST-INFO | started process 25034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp7bE1a/profile http://localhost:46989/getInfo.html) 03:35:08 INFO - PROCESS | 25034 | 03:35:08 INFO - PROCESS | 25034 | (process:25116): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:35:09 INFO - PROCESS | 25034 | __metrics Screen width/height:1600/1200 03:35:09 INFO - PROCESS | 25034 | colorDepth:24 03:35:09 INFO - PROCESS | 25034 | Browser inner width/height: 1024/697 03:35:09 INFO - PROCESS | 25034 | __metrics 03:35:10 ERROR - PROCESS | 25034 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:35:10 INFO - TEST-INFO | 25034: exit 0 03:35:10 INFO - Browser initialized. 03:35:10 INFO - Running cycle 1/1 for kraken test... 03:35:10 INFO - TEST-INFO | started process 25167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp7bE1a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:12 INFO - PROCESS | 25167 | 03:35:12 INFO - PROCESS | 25167 | (process:25234): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:35:22 INFO - PROCESS | 25167 | RSS: Main: 152506368 03:35:22 INFO - PROCESS | 25167 | 03:35:25 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46989/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:25 INFO - PROCESS | 25167 | RSS: Main: 157143040 03:35:25 INFO - PROCESS | 25167 | 03:35:28 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46989/tests/kraken/driver.html?testName=audio-dft) 03:35:29 INFO - PROCESS | 25167 | RSS: Main: 157392896 03:35:29 INFO - PROCESS | 25167 | 03:35:32 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46989/tests/kraken/driver.html?testName=audio-fft) 03:35:32 INFO - PROCESS | 25167 | RSS: Main: 157798400 03:35:32 INFO - PROCESS | 25167 | 03:35:34 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46989/tests/kraken/driver.html?testName=audio-oscillator) 03:35:35 INFO - PROCESS | 25167 | RSS: Main: 157196288 03:35:35 INFO - PROCESS | 25167 | 03:35:37 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46989/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:38 INFO - PROCESS | 25167 | RSS: Main: 157274112 03:35:38 INFO - PROCESS | 25167 | 03:35:41 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46989/tests/kraken/driver.html?testName=imaging-darkroom) 03:35:41 INFO - PROCESS | 25167 | RSS: Main: 157655040 03:35:41 INFO - PROCESS | 25167 | 03:35:45 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46989/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:45 INFO - PROCESS | 25167 | RSS: Main: 157741056 03:35:45 INFO - PROCESS | 25167 | 03:35:48 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46989/tests/kraken/driver.html?testName=json-parse-financial) 03:35:49 INFO - PROCESS | 25167 | RSS: Main: 157499392 03:35:49 INFO - PROCESS | 25167 | 03:35:50 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46989/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:51 INFO - PROCESS | 25167 | RSS: Main: 157024256 03:35:51 INFO - PROCESS | 25167 | 03:35:53 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46989/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:53 INFO - PROCESS | 25167 | RSS: Main: 157356032 03:35:53 INFO - PROCESS | 25167 | 03:35:55 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46989/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:35:56 INFO - PROCESS | 25167 | RSS: Main: 157470720 03:35:56 INFO - PROCESS | 25167 | 03:35:59 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:35:59 INFO - PROCESS | 25167 | RSS: Main: 158060544 03:35:59 INFO - PROCESS | 25167 | 03:36:02 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:03 INFO - PROCESS | 25167 | RSS: Main: 158035968 03:36:03 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | Cycle 1(1): loaded http://localhost:46989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46989/tests/kraken/driver.html?testName=ai-astar) 03:36:04 INFO - PROCESS | 25167 | RSS: Main: 159703040 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | __start_tp_report 03:36:04 INFO - PROCESS | 25167 | _x_x_mozilla_page_load 03:36:04 INFO - PROCESS | 25167 | _x_x_mozilla_page_load_details 03:36:04 INFO - PROCESS | 25167 | |i|pagename|runs| 03:36:04 INFO - PROCESS | 25167 | |0;ai-astar;111;107;109;109;111;123;110;111;110;109 03:36:04 INFO - PROCESS | 25167 | |1;audio-beat-detection;157;125;152;172;127;161;156;131;189;127 03:36:04 INFO - PROCESS | 25167 | |2;audio-dft;162;162;162;161;162;162;162;164;163;162 03:36:04 INFO - PROCESS | 25167 | |3;audio-fft;76;74;75;163;76;76;73;76;171;76 03:36:04 INFO - PROCESS | 25167 | |4;audio-oscillator;92;93;152;91;95;93;149;91;92;147 03:36:04 INFO - PROCESS | 25167 | |5;imaging-gaussian-blur;118;118;118;117;118;118;117;117;117;117 03:36:04 INFO - PROCESS | 25167 | |6;imaging-darkroom;147;148;147;146;146;147;146;147;147;147 03:36:04 INFO - PROCESS | 25167 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;96 03:36:04 INFO - PROCESS | 25167 | |8;json-parse-financial;57;59;59;61;60;62;58;83;57;62 03:36:04 INFO - PROCESS | 25167 | |9;json-stringify-tinderbox;58;59;59;58;59;58;58;58;59;58 03:36:04 INFO - PROCESS | 25167 | |10;stanford-crypto-aes;75;74;76;74;75;84;75;76;76;74 03:36:04 INFO - PROCESS | 25167 | |11;stanford-crypto-ccm;122;130;132;120;123;120;134;127;151;126 03:36:04 INFO - PROCESS | 25167 | |12;stanford-crypto-pbkdf2;162;159;163;159;164;162;159;161;168;161 03:36:04 INFO - PROCESS | 25167 | |13;stanford-crypto-sha256-iterative;66;69;67;67;67;65;67;69;67;66 03:36:04 INFO - PROCESS | 25167 | __end_tp_report 03:36:04 INFO - PROCESS | 25167 | __start_cc_report 03:36:04 INFO - PROCESS | 25167 | _x_x_mozilla_cycle_collect,834 03:36:04 INFO - PROCESS | 25167 | __end_cc_report 03:36:04 INFO - PROCESS | 25167 | __startTimestamp1462530964977__endTimestamp 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | ------- Summary: start ------- 03:36:04 INFO - PROCESS | 25167 | Number of tests: 14 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#0] ai-astar Cycles:10 Average:111.00 Median:110.50 stddev:4.40 (4.0%) stddev-sans-first:4.66 03:36:04 INFO - PROCESS | 25167 | Values: 111.0 107.0 109.0 109.0 111.0 123.0 110.0 111.0 110.0 109.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:156.50 stddev:21.75 (13.9%) stddev-sans-first:22.91 03:36:04 INFO - PROCESS | 25167 | Values: 157.0 125.0 152.0 172.0 127.0 161.0 156.0 131.0 189.0 127.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:36:04 INFO - PROCESS | 25167 | Values: 162.0 162.0 162.0 161.0 162.0 162.0 162.0 164.0 163.0 162.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:38.74 (51.0%) stddev-sans-first:40.57 03:36:04 INFO - PROCESS | 25167 | Values: 76.0 74.0 75.0 163.0 76.0 76.0 73.0 76.0 171.0 76.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:27.54 (29.9%) stddev-sans-first:28.47 03:36:04 INFO - PROCESS | 25167 | Values: 92.0 93.0 152.0 91.0 95.0 93.0 149.0 91.0 92.0 147.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:36:04 INFO - PROCESS | 25167 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:36:04 INFO - PROCESS | 25167 | Values: 147.0 148.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 147.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:36:04 INFO - PROCESS | 25167 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:60.50 stddev:7.67 (12.7%) stddev-sans-first:7.94 03:36:04 INFO - PROCESS | 25167 | Values: 57.0 59.0 59.0 61.0 60.0 62.0 58.0 83.0 57.0 62.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 03:36:04 INFO - PROCESS | 25167 | Values: 58.0 59.0 59.0 58.0 59.0 58.0 58.0 58.0 59.0 58.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.50 stddev:2.96 (3.9%) stddev-sans-first:3.12 03:36:04 INFO - PROCESS | 25167 | Values: 75.0 74.0 76.0 74.0 75.0 84.0 75.0 76.0 76.0 74.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:128.50 stddev:9.29 (7.2%) stddev-sans-first:9.55 03:36:04 INFO - PROCESS | 25167 | Values: 122.0 130.0 132.0 120.0 123.0 120.0 134.0 127.0 151.0 126.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:162.00 stddev:2.78 (1.7%) stddev-sans-first:2.95 03:36:04 INFO - PROCESS | 25167 | Values: 162.0 159.0 163.0 159.0 164.0 162.0 159.0 161.0 168.0 161.0 03:36:04 INFO - PROCESS | 25167 | 03:36:04 INFO - PROCESS | 25167 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.27 03:36:04 INFO - PROCESS | 25167 | Values: 66.0 69.0 67.0 67.0 67.0 65.0 67.0 69.0 67.0 66.0 03:36:04 INFO - PROCESS | 25167 | -------- Summary: end -------- 03:36:04 INFO - PROCESS | 25167 | 03:36:05 INFO - TEST-INFO | 25167: exit 0 03:36:05 INFO - TEST-OK | kraken | took 60321ms 03:36:05 INFO - SUITE-END | took 1168s 03:36:06 INFO - Completed test suite (00:19:29) 03:36:06 INFO - javascript benchmark 03:36:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3344.832758362081, 3359.781614195078, 3363.8149901755423, 3408.4376077947154, 3413.453847384419, 5559.861003474915, 5560.610757246995, 5578.219049333092, 5594.272744543208, 5594.9720251398785, 5536.723163841812, 5550.47270509302, 5568.777248910049, 5597.524210442107, 5615.045442274813, 5069.391672999236, 5134.358205224347, 5141.537261646451, 5154.046501397253, 5172.534471897528, 5007.123753343169, 5147.897042059157, 5268.288781014571, 5277.208418737201, 5302.098643230641, 5119.078565858144, 5158.303629010092, 5172.586193104561, 5286.154215325549, 5302.363716354023, 5162.535371816554, 5192.376914770233, 5199.688018718889, 5212.921806172911, 5214.5306922376785, 5108.259302401131, 5151.2273159026445, 5162.045021671003, 5210.76551555181, 5243.947560524384, 5431.592630552725, 5447.673139611636, 5518.144687573433, 5566.914451681923, 5584.022796010722, 6035.0, 6038.2150320458495, 6044.395560443964, 6067.544934129958, 6070.3019152797115, 6041.214642096544, 6087.786927457518, 6104.14541964121, 6107.7556897724035, 6109.633421994695, 5471.753771080311, 5553.500184983371, 5634.492895639371, 5635.351934527541, 5653.604247702662, 6095.238095238095, 6103.023516237469, 6110.388961103854, 6125.816225513242, 6129.049997250433, 5707.486326230659, 5880.911786323209, 5891.293044834561, 5906.793262235801, 5917.733701983335, 5782.2194003808945, 5875.383084776123, 5890.440408161217, 5908.615939963888, 5911.379305172895, 5971.134185543072, 5975.701214939236, 5986.281646202484, 5991.58058935879, 6002.939970600325, 5825.737841797045, 5916.497097746654, 5984.7606095756555, 5989.730462129215, 5990.071538911476, 4533.954660453419, 4603.148417542765, 4605.355250264965, 4606.239970404913, 4634.235351167087, 4115.053537686349, 4125.360569111793, 4126.174765047002, 4140.0, 4156.25187466259, 5657.066584013674, 5731.799387021518, 5799.39106393831, 5825.854353641193, 5827.242458480455, 5932.881342373128, 5992.970035149797, 6018.097285407224, 6092.939070609325, 6097.298810636745, 5696.601237913389, 5710.571707121982, 5725.914111288334, 5743.4256574342235, 5764.798232061858, 5060.342155519833, 5118.360204974379, 5130.461301563357, 5144.331236939249, 5175.81884634036, 6158.568900176944, 6182.381761823782, 6192.287886892975, 6223.875522489525, 6246.031865060922, 5945.078512830518, 5967.19442875215, 5999.1901093351835, 6007.849803754766, 6035.004224303117, 6083.057126145454, 6207.286162091236, 6211.099390588249, 6313.337099604475, 6360.014197799349, 5883.911741323798, 5884.205632239593, 5893.823185304448, 5904.0, 5916.763329466945, 5960.642361458326, 5968.045112781934, 5968.731407086779, 5990.550708696952, 5994.550408719277, 5737.0, 5893.528517718658, 5969.403059693996, 5974.103884417372, 6007.30915944672, 5835.737391817293, 5872.823815285548, 5874.970625146847, 5875.177475153568, 5876.735546900314, 5731.656100633975, 5777.653340799566, 5779.162021506942, 5792.160136780059, 5801.1878337032, 5789.681567513827, 5880.26496687914, 5920.822375328747, 5959.106134079922, 6004.249468816398, 5815.592908496534, 5821.621594596338, 5825.213596164633, 5826.70866456684, 5839.678817665069], "value": 5549.999726306718, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.1901708761523, 637.799093285615, 652.928177900431, 688.1260798785543, 696.2654399608417, 39101.608983910155, 40302.0, 40377.59622403775, 40421.595784042154, 40623.18753624926, 43729.34405983905, 44670.32994505085, 44873.551264487345, 44888.10223795522, 44927.775361123146, 8721.302295816351, 8880.46717196967, 8888.288936885034, 8934.910650893473, 8943.508107054142, 8803.0, 8920.46477211366, 8925.687600933968, 8933.15135062168, 8938.195562399384, 8852.026277109546, 8877.245434138105, 8878.334124940655, 8878.378513504058, 8955.820883582324, 8849.646014159425, 8889.155530224618, 8903.777405564913, 8908.777280567972, 8930.062343453941, 8740.825183496358, 8784.956075219647, 8837.469751814911, 8878.0, 8891.510966896818, 40818.79590602028, 41130.58869411297, 41273.0, 41317.58682413198, 41561.58438415607, 3773.8490460381554, 4200.4959404871615, 4320.82716691332, 4483.4843992940905, 4677.18149323867, 33036.834815826005, 33466.330673386394, 33562.1609459763, 33606.6639333606, 34230.48654270188, 4569.405977222973, 4609.354690343354, 4610.415424368926, 4620.237660785966, 4642.814287428499, 323474.0, 325030.0, 326844.9999999976, 329440.0, 329606.0, 54981.175282370794, 55876.16185757136, 56032.71983640056, 56146.0, 56218.0, 61460.0, 62664.0, 62985.37014629795, 63184.0, 63428.0, 18526.722099168255, 18582.628347432976, 18752.0, 18772.0, 18808.435746927615, 14406.927965360315, 14449.855501445061, 14482.420703171965, 14532.927335363256, 14569.0, 20500.38498845037, 20567.794322056587, 20939.37181884546, 21449.57100857974, 21483.57032859334, 7547.8113047173165, 7548.924510754932, 7871.606419678993, 7968.12350641429, 8006.879896801553, 1136.091127098318, 1184.7867383870987, 1185.5968970550055, 1203.5377016924479, 1216.1669256559107, 32811.83594082014, 33373.332533349196, 33461.66538334634, 33546.539474734454, 33931.66068339285, 1133.110508251019, 1161.8024935760773, 1184.8281999110081, 1221.328269451798, 1238.9814152787715, 17567.560810979827, 17608.295668173385, 17802.643947120985, 17838.46484605438, 17840.55398615045, 314693.0, 319345.0, 319729.0, 446855.0, 499003.0, 62177.68911155415, 64334.356656433774, 64501.0, 64534.35465645284, 64603.67698161573, 1524.2531159731652, 1527.7402841516969, 1533.325336851804, 1540.0, 1556.486359501362, 32623.836880815445, 33046.17384565405, 33299.00102996914, 33313.50029749507, 34126.0, 52539.737301313246, 53213.0, 53303.200451992474, 53320.46679533155, 53385.0, 518708.0, 521866.0, 522663.0, 522688.0, 524975.0, 30784.076477705705, 31173.376532469676, 31516.842415787774, 31530.527042093927, 31712.36575268528, 48718.75640621774, 48784.26823597578, 48841.51158488512, 49654.0, 50154.0, 41740.58259417367, 41991.7900410496, 42047.15905681808, 42261.78869105635, 43023.78488107539, 40556.1888762229, 40905.79547102245, 41641.58358416498, 41834.0, 42997.785011074746, 42170.7891460553, 42453.787731061144, 42515.7874210627, 42986.785066074466, 43121.35317970296, 35409.0, 36636.26727465382, 36766.44850327194, 37338.8133059333, 37525.249495010496, 28446.57330140091, 29301.26746831261, 29325.560116598695, 29333.55999659964, 29702.851485742434], "value": 20880.70825402796, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.96523795477367, 413.3242149086243, 415.119945715084, 416.5563674686459, 425.2069889655793, 18663.253469861207, 19160.71258931117, 19348.51628709283, 19389.224431022743, 20098.0, 11793.882061179407, 11997.520099196021, 12173.391330433466, 12254.754904901896, 12374.381280935962, 5204.609654275935, 5312.814051508179, 5318.654287471321, 5319.0957537218765, 5349.438308977559, 5246.632735708502, 5886.852828679274, 5915.763369465216, 5920.200772895647, 5935.821925342247, 5794.159846822208, 5848.590598658096, 5860.296764388258, 5870.060790273557, 5871.236739223917, 5344.4922732340365, 5624.578156638268, 5630.296212973379, 5630.493255607015, 5652.010898092838, 5400.864978375533, 5494.038543254915, 5695.829125126253, 5748.051571490699, 5757.107648314476, 12996.740065198643, 13028.348582570834, 13125.86874131256, 13128.01539884503, 13756.518521851787, 2293.3005433342823, 2349.459624286407, 2364.2907127861745, 2374.1097088591778, 2562.7821635161035, 9856.260780441495, 10003.499825008794, 10243.0, 10266.538005789758, 10326.122279606243, 1973.2797528901847, 2001.549651328454, 2018.3944816555122, 2106.2838634864065, 2170.3271985684487, 80860.59569702172, 81754.0, 82557.0, 84406.0, 84799.0, 10776.568937242579, 10791.0, 11428.428578571038, 11480.425978701032, 11481.655550333504, 15825.050496970218, 15907.204639767966, 15923.283452244677, 15930.920345398199, 16016.119113448873, 8448.112948140357, 8466.068732439428, 8602.010768761547, 8607.569621518898, 8625.0943650917, 8243.546604936786, 8330.8333833323, 8411.789705257295, 8422.494650321001, 8550.444221125606, 4616.815327386934, 4669.766511674403, 4728.345079222245, 4753.025629745894, 4938.654294199371, 1896.5922326699826, 2027.4221846773598, 2054.815066644009, 2067.7415323084615, 2069.244725675118, 961.8461046232569, 1005.1355833982769, 1055.4036969112426, 1105.4583254205543, 1119.5801574409597, 18724.625507489774, 19249.422517324503, 19366.61266774685, 19370.846875452353, 19380.612387752168, 1082.5723839083519, 1083.47992963378, 1119.9776004479866, 1126.1980830670861, 1161.1523587780798, 10706.89293107059, 11015.889841101647, 11126.944365278121, 11187.552497900155, 11192.328460292245, 403269.0, 405958.0, 406409.0, 407288.0, 555094.0, 58786.0, 61701.691491543155, 62158.37841621526, 100011.0, 103860.48069759602, 1108.7172770943519, 1129.2546919033398, 1150.6411855695958, 1157.0107558037926, 1159.5072094359864, 17754.37859674905, 17890.731639025686, 18005.099745012958, 18078.367257145936, 18192.72710909311, 40914.59085409227, 41642.58357416387, 42169.0, 42635.23146699195, 43348.56651433445, 57947.0, 58127.0, 59335.40664593299, 60167.699161503915, 60892.0, 8290.419670622998, 8434.451760635538, 8744.256738177326, 8782.209601135928, 8943.418677785923, 12578.622641320775, 13454.798178027142, 13789.586312410644, 14299.21354325522, 14422.927885360506, 12526.49894004266, 12536.623901282976, 12538.122331436713, 12623.747525049264, 12827.807582886451, 12274.140810143204, 12347.69130771738, 12501.624951251477, 12645.683857903257, 12802.0, 12428.751424971631, 12650.810237846625, 12791.936040319739, 12842.357882106044, 13041.152325098838, 8899.15458031486, 8908.777280568038, 8970.192682658591, 9042.321825863219, 9071.863922041306, 8896.332775041768, 12495.875041249836, 12525.123241373016, 12677.936610316889, 12798.87201128014], "value": 9144.856887863842, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1610.2351383093032, 1623.9594010149744, 1836.614310994691, 1905.1902941249966, 1943.018775518363, 7644.541327520353, 8195.87706184407, 8276.089630140696, 8521.78695532612, 8621.741347759562, 8270.95864520678, 8319.958400208006, 8381.32949364051, 8435.325173986083, 8445.113263107378, 2319.060780383947, 2329.440934175794, 2346.800521955627, 2352.741198468167, 2355.7762012608773, 2309.0417476747216, 2311.884405779713, 2359.7994170495526, 2365.1840115160244, 2366.6095094309417, 2331.3472227776165, 2357.3281614739803, 2372.323887692008, 2393.7606239376096, 2395.9161429349974, 2267.807236384909, 2291.9885400572975, 2311.7803808638237, 2315.0161181497797, 2341.2976107167783, 2296.632538793802, 2298.2990187992655, 2306.5386922615544, 2311.3297143828268, 2318.211807985276, 8484.19400156984, 8536.74389768308, 8547.102554231778, 8550.059493455716, 8573.871391929126, 5050.671706339113, 5099.71951542665, 5181.766820493087, 5242.79028838846, 5251.10731175701, 3135.2064002556936, 3162.857671404792, 3171.920701982469, 3239.400710868497, 3261.771675982682, 1045.1012129568564, 1045.5608644369383, 1052.2160990062375, 1059.9788004239872, 1096.7970925378831, 11330.150238732129, 11372.203945723802, 11390.886091139066, 11408.258463199865, 11466.885331146665, 4428.13651337986, 4468.32975053738, 4547.954520454819, 4557.635389168859, 4598.747068911175, 9810.21518278536, 9821.656242031495, 9874.358166719141, 9874.901250987541, 9877.308588398742, 5134.897302053938, 5148.0, 5154.61340399464, 5197.272381866542, 5205.557527610195, 4268.061026574149, 4697.365855609449, 4726.95273047272, 4815.133276010351, 4889.413270407503, 4033.193361327746, 4092.1815636872743, 4136.586341365839, 4155.667546596265, 4205.0, 1265.3104058288254, 1294.6633875192517, 1301.9934900325438, 1302.0625149892253, 1316.8419789625307, 983.1348413396308, 1004.6182450668845, 1024.8206563851445, 1038.2939601071344, 1039.0440794469107, 5850.0, 5982.611130276518, 6019.729112189962, 6063.423974722395, 6189.50483961282, 947.7489713578149, 964.62379671928, 1004.2016596805557, 1017.4810846468355, 1047.8847326794046, 3851.2297540492013, 3916.4516967624554, 3916.5104361954754, 3951.5258169019903, 3974.066094467798, 10211.183105351554, 10600.416977066181, 10650.946745266225, 10732.87304832997, 10779.461026948622, 10459.163266938627, 10572.36565806054, 10650.840237396445, 10655.786884262272, 10659.093977011886, 7883.172266912006, 7983.0, 8117.715879944291, 8135.593220339078, 8158.877616835753, 5664.745086471036, 5681.431856814285, 5743.339515955551, 5798.275215598051, 5840.795572154954, 9382.10869967352, 9628.374155679858, 9644.132028117223, 9743.464109474047, 9778.65774697882, 9551.617935282511, 9683.41899486033, 9820.263480239153, 9846.606135754777, 9950.303478756417, 6456.192975878015, 7043.929560704328, 7086.078809754699, 7216.675249613885, 7381.667824947783, 8331.916680833356, 8337.124601916712, 8366.205210504992, 8414.326853851555, 8435.789105272417, 7428.294312040348, 7583.544987300559, 7643.121041080347, 7730.613469326398, 7745.961270193613, 7266.273372662691, 7304.817379565553, 7326.633668316669, 7374.004509391378, 7522.059742532184, 7340.779776606711, 7384.778456646309, 7400.444966627632, 7424.888626670712, 7446.962765186356, 5006.799728010985, 5051.318072060225, 5157.742112894415, 5161.741912904415, 5180.041692286939, 4967.677100988424, 5050.72221027847, 5135.435102138837, 5170.48295170495, 5200.843974680765], "value": 4581.591575264339, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.7489970373256, 326.90683155300735, 333.0275595261836, 333.6246722437258, 333.92987472630745, 5731.541476681866, 5819.272590926134, 5827.086456771614, 5836.21211136497, 5838.532917366617, 5619.831405057845, 5665.461781130786, 5691.174779656947, 5711.371749107595, 5713.485786279244, 4167.499700107959, 4241.978790106045, 4395.582419670142, 4408.537103604123, 4443.60007599316, 4412.176207227361, 4423.9603693132085, 4427.535108813577, 4427.712198707074, 4433.401490798749, 4370.912581748363, 4398.516163222043, 4404.515503294635, 4417.73493590384, 4429.269170586849, 4338.869833904988, 4368.563143685637, 4380.846670366522, 4398.8123206734, 4402.0, 3846.096182389707, 3850.2876967761053, 3852.499175107218, 3856.8842934712, 3877.5346958364894, 5529.529989950859, 5543.697231150676, 5545.500904918536, 5549.972250138723, 5562.666240025571, 4869.586085182764, 5013.623978201613, 5021.698698078127, 5030.0, 5062.721550314731, 5961.837441698871, 5973.581849270553, 5986.401359864022, 6025.096235564701, 6027.794441111751, 4246.473348357722, 4251.893702657428, 4253.3619957006695, 4254.638355739766, 4258.041940563379, 6061.636301821904, 6142.894279029772, 6143.569950103494, 6192.938070619326, 6202.286737025254, 4299.0, 4310.741355518679, 4328.761918094472, 4338.783060846945, 4348.499922508889, 4377.212101821639, 4380.386745855582, 4396.1867054595, 4396.450443694538, 4399.120175964756, 4901.240307752304, 4950.8762280943265, 4998.375203099613, 5014.799408023711, 5015.774290156952, 5982.670953097534, 6021.2473440819895, 6044.818655440344, 6051.636901785907, 6061.696915154224, 1566.6631674190103, 1606.0604546340521, 1610.0983449268213, 1611.0011792688608, 1611.653494498665, 1009.7526106104051, 1041.1202533858877, 1071.539238127597, 1077.342820879263, 1078.3475997021847, 6184.443400094013, 6256.499480041586, 6260.40526150015, 6291.1192433059405, 6293.527985401113, 6535.3464653534265, 6570.310117437696, 6580.76967306142, 6597.802065937934, 6618.139641846529, 5707.229524014288, 5947.197128387612, 5964.522838172936, 6006.729697163638, 6027.7890273841085, 3543.167355671415, 3576.7853928764357, 3591.8865151803025, 3595.0, 3604.891853244407, 6141.692915354214, 6493.285738568754, 6507.8698426031215, 6517.771877984248, 6955.817511023139, 6350.190195794176, 6419.165508483868, 6419.967900160469, 6440.54916155874, 6467.741290348427, 6370.299267080617, 6491.740330386826, 6536.215654121535, 6536.477081833442, 6538.444232240313, 6250.624962502265, 6276.466500347522, 6282.497400207881, 6287.182666253358, 6326.746930122744, 5949.315828679757, 6150.507959363151, 6170.92008898432, 6184.938150618616, 6199.442050215503, 6513.436775173829, 6546.934530654823, 6556.967215163893, 6578.76974305897, 6622.503312251697, 4277.144571085858, 4328.978355108205, 4330.41539392178, 4345.435093437833, 4363.956360436355, 6248.375162483715, 6335.936640633535, 6336.778212762531, 6354.332795056453, 6382.234131904015, 6136.2636483622255, 6154.1999540059505, 6161.568690191643, 6181.629102253879, 6208.689565521616, 5933.554983376178, 6091.7258723358445, 6120.510359171345, 6145.385461453819, 6185.793770214765, 5735.197072409783, 5892.793752218652, 5999.850003749942, 6069.393060693896, 6071.692756752406, 6050.576459647782, 6106.1451396803595, 6171.56799024064, 6172.783952561639, 6196.535259855619, 5654.858628534155, 5993.130996005642, 6031.155638210742, 6046.609279865567, 6053.697315134137], "value": 4624.957136023672, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.7134431309823, 894.5661552498734, 900.5137225898011, 904.6019751309424, 923.7413524213214, 14166.504172353969, 14287.357068931897, 14526.34631441585, 14731.852681473169, 14827.110373377605, 14122.788158177636, 14189.645258868533, 14192.432302707904, 14243.643908902282, 14263.072900261503, 762.1463960364372, 773.1456740301942, 907.4237858959575, 916.5142474488532, 916.9954150229239, 910.4901255297054, 911.2983003087619, 912.4160537256162, 918.6922381002372, 919.2462181011573, 946.4605175050224, 953.4231789767196, 953.5232383808096, 956.4787190980932, 956.4978386347188, 935.6351023100996, 938.7324612485477, 940.5203346293406, 942.4816351006988, 944.8629948657441, 690.3338278561213, 695.7286658203304, 696.3245651717825, 696.4184905603777, 701.4949236549676, 14626.780598291034, 14643.12141271527, 14688.779668304984, 14698.55904322872, 14731.410743570244, 14981.0, 14991.700165996619, 15079.396824127021, 15177.620559485991, 15218.619534511616, 10786.244962852603, 10830.945845270802, 11023.118150547936, 11316.434178291134, 11714.53141874324, 3885.067583779901, 3893.6301051400073, 3919.0790164311366, 3923.097687531884, 4060.979695101535, 57421.712891435694, 58096.41903580952, 58444.41555584432, 60289.39710602925, 60837.69581152066, 11352.716182095348, 11504.25222360544, 11567.826482602768, 11671.299722016705, 11752.0, 19171.808281917, 19727.40817775469, 19728.506787330145, 19834.107465164103, 19906.90046549758, 8628.22345988864, 8718.43330183536, 8877.983939074402, 9100.0, 9212.585433655502, 4958.578520825698, 4996.482745638121, 5019.779696810459, 5083.771230294646, 5098.694078355311, 3426.9657303427143, 3452.913677158041, 3459.8270086495572, 3461.4115600348, 3473.8089405082965, 648.3063122459018, 675.9763408280785, 677.7492327838731, 690.4441924251026, 691.8339598496325, 773.4083426178978, 775.8168792591231, 831.1750289568989, 835.0688981785265, 835.7200337886754, 9634.951825240829, 9679.66121185755, 9740.366876153028, 9802.068803463659, 10060.295779295526, 601.9414592130282, 646.5377255262509, 682.5051837417832, 689.8689249042666, 749.5877267502851, 4058.4723985882238, 4093.7953102344763, 4108.075682971307, 4132.669386449077, 4142.834286628561, 64062.67968660127, 65266.347336526975, 65518.0, 66404.0, 66588.6670566644, 56750.43249567534, 57093.0, 58091.0, 58829.117563236585, 59665.0, 50007.999840002994, 50503.24245136326, 50972.74513627408, 51216.23175652368, 51624.741876290376, 8782.121787821166, 9012.188902998761, 9143.405678630868, 9169.816603667756, 9188.632454701738, 30863.0, 32445.02664920056, 32485.35029299448, 32974.17564560905, 34256.143596410286, 46167.0, 47129.0, 47145.764271179796, 48003.5199647999, 48509.0, 11900.642980710592, 12230.266184028987, 12389.690257743629, 12468.189567678071, 12664.556740514037, 13887.791683124964, 13896.51362202318, 14160.079594826304, 14692.338844751797, 14694.926525367304, 11707.824382634097, 11887.16789824704, 12218.083643726579, 13965.231912244924, 14525.78211326852, 13775.586732398044, 13787.379567919668, 13849.861501384858, 13939.860601393857, 14028.859711402756, 12268.44791984345, 12796.424160912595, 12861.742765144832, 13059.673508162372, 13725.382357793724, 11432.428378580871, 11719.296842189497, 11760.647180584596, 11913.801135969541, 12053.216540924812, 10657.467126643482, 11211.71970700739, 11225.382603956534, 11352.659420217407, 11469.483873225892], "value": 7079.251966352581, "unit": "score"}], "name": "dromaeo_css", "value": 7360.2886940117405, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 109.0, 109.0, 111.0, 123.0, 110.0, 111.0, 110.0, 109.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 152.0, 172.0, 127.0, 161.0, 156.0, 131.0, 189.0, 127.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 164.0, 163.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 163.0, 76.0, 76.0, 73.0, 76.0, 171.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 152.0, 91.0, 95.0, 93.0, 149.0, 91.0, 92.0, 147.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 59.0, 61.0, 60.0, 62.0, 58.0, 83.0, 57.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 74.0, 75.0, 84.0, 75.0, 76.0, 76.0, 74.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 132.0, 120.0, 123.0, 120.0, 134.0, 127.0, 151.0, 126.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 163.0, 159.0, 164.0, 162.0, 159.0, 161.0, 168.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 67.0, 67.0, 65.0, 67.0, 69.0, 67.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1538.9, "alertThreshold": 2.0}]} 03:36:06 INFO - Return code: 0 03:36:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:36:06 ERROR - # TBPL SUCCESS # 03:36:06 INFO - Running post-action listener: _resource_record_post_action 03:36:06 INFO - Running post-run listener: _resource_record_post_run 03:36:07 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 266240; Write bytes: 512401408; Read time: 32; Write time: 409768 03:36:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248823808; Read time: 0; Write time: 245800 03:36:07 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252317696; Read time: 32; Write time: 159860 03:36:07 INFO - Running post-run listener: _upload_blobber_files 03:36:07 INFO - Blob upload gear active. 03:36:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:36:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:36:07 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:36:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:36:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:08 INFO - (blobuploader) - INFO - Done attempting. 03:36:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:36:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:36:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:09 INFO - (blobuploader) - INFO - Done attempting. 03:36:09 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:09 INFO - Return code: 0 03:36:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd28053aacba683685193d199ece4623158a9863e1c74cf621b5bf4add67b90fa067a5e3f94de5006331d0067a62cc443fede26661c56ec9877346f64daa7ae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e08715c4aa50897e5a9d28128b58ace5eef1b429f9299ac350b2b269ea2b8e24d1f8f4df5c528ed7b3fc7f06d5a8908e5226e48b309859b81fcc7135f8023203"} 03:36:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:09 INFO - Contents: 03:36:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd28053aacba683685193d199ece4623158a9863e1c74cf621b5bf4add67b90fa067a5e3f94de5006331d0067a62cc443fede26661c56ec9877346f64daa7ae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e08715c4aa50897e5a9d28128b58ace5eef1b429f9299ac350b2b269ea2b8e24d1f8f4df5c528ed7b3fc7f06d5a8908e5226e48b309859b81fcc7135f8023203"} 03:36:09 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:09 INFO - Copying logs to upload dir... 03:36:09 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.677634 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-06 03:36:08.979347) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:08.982938) ========= 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=0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691 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/bd28053aacba683685193d199ece4623158a9863e1c74cf621b5bf4add67b90fa067a5e3f94de5006331d0067a62cc443fede26661c56ec9877346f64daa7ae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e08715c4aa50897e5a9d28128b58ace5eef1b429f9299ac350b2b269ea2b8e24d1f8f4df5c528ed7b3fc7f06d5a8908e5226e48b309859b81fcc7135f8023203"} build_url:https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011106 build_url: 'https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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/bd28053aacba683685193d199ece4623158a9863e1c74cf621b5bf4add67b90fa067a5e3f94de5006331d0067a62cc443fede26661c56ec9877346f64daa7ae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e08715c4aa50897e5a9d28128b58ace5eef1b429f9299ac350b2b269ea2b8e24d1f8f4df5c528ed7b3fc7f06d5a8908e5226e48b309859b81fcc7135f8023203"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:09.007169) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:09.007463) ========= 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=0333a256a5e4f052382dd180000001b1-1462524158.725440-1555879691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:09.092270) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:36:09.092594) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:36:09.092867) ========= ========= Total master_lag: 0.18 =========