builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1462533649.96 results: success (0) buildid: 20160506013623 builduid: 3e330e94e72a44aabac68afc380e9ed1 revision: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:49.959269) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:49.959779) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:49.960067) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:49.978339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:49.978752) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 04:20:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-05-06 04:20:50 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.333471 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:50.326931) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:50.327519) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017635 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:50.378736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:50.379134) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f --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 b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 04:20:50,658 truncating revision to first 12 chars 2016-05-06 04:20:50,658 Setting DEBUG logging. 2016-05-06 04:20:50,658 attempt 1/10 2016-05-06 04:20:50,658 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b61ad3a6049c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 04:20:50,928 unpacking tar archive at: mozilla-aurora-b61ad3a6049c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552053 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:50.944612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:50.944943) ========= script_repo_revision: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:50.945369) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:50.945661) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 04:20:50.953726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-06 04:20:50.954016) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:20:51 INFO - MultiFileLogger online at 20160506 04:20:51 in /builds/slave/test 04:20:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:20:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:20:51 INFO - {'append_to_log': False, 04:20:51 INFO - 'base_work_dir': '/builds/slave/test', 04:20:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:20:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:20:51 INFO - 'branch': 'Mozilla-Aurora', 04:20:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:20:51 INFO - 'config_files': ('talos/linux_config.py',), 04:20:51 INFO - 'default_actions': ('clobber', 04:20:51 INFO - 'read-buildbot-config', 04:20:51 INFO - 'download-and-extract', 04:20:51 INFO - 'populate-webroot', 04:20:51 INFO - 'create-virtualenv', 04:20:51 INFO - 'install', 04:20:51 INFO - 'run-tests'), 04:20:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:20:51 INFO - 'download_minidump_stackwalk': True, 04:20:51 INFO - 'download_symbols': 'ondemand', 04:20:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:20:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:20:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:20:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:20:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:20:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:20:51 INFO - 'installer_path': 'installer.exe', 04:20:51 INFO - 'log_level': 'info', 04:20:51 INFO - 'log_name': 'talos', 04:20:51 INFO - 'log_to_console': True, 04:20:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:20:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:20:51 INFO - 'opt_config_files': (), 04:20:51 INFO - 'pip_index': False, 04:20:51 INFO - 'sps_profile': False, 04:20:51 INFO - 'sps_profile_interval': 0, 04:20:51 INFO - 'suite': 'dromaeojs', 04:20:51 INFO - 'system_bits': '32', 04:20:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:20:51 INFO - 'title': 'talos-linux64-ix-064', 04:20:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:20:51 INFO - 'use_talos_json': True, 04:20:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:20:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:20:51 INFO - 'work_dir': 'build'} 04:20:51 INFO - ##### 04:20:51 INFO - ##### Running clobber step. 04:20:51 INFO - ##### 04:20:51 INFO - Running pre-action listener: _resource_record_pre_action 04:20:51 INFO - Running main action method: clobber 04:20:51 INFO - rmtree: /builds/slave/test/build 04:20:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:52 INFO - Running post-action listener: _resource_record_post_action 04:20:52 INFO - ##### 04:20:52 INFO - ##### Running read-buildbot-config step. 04:20:52 INFO - ##### 04:20:52 INFO - Running pre-action listener: _resource_record_pre_action 04:20:52 INFO - Running main action method: read_buildbot_config 04:20:52 INFO - Using buildbot properties: 04:20:52 INFO - { 04:20:52 INFO - "project": "", 04:20:52 INFO - "product": "firefox", 04:20:52 INFO - "script_repo_revision": "production", 04:20:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:20:52 INFO - "repository": "", 04:20:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:20:52 INFO - "buildid": "20160506013623", 04:20:52 INFO - "pgo_build": "True", 04:20:52 INFO - "basedir": "/builds/slave/test", 04:20:52 INFO - "buildnumber": 221, 04:20:52 INFO - "slavename": "talos-linux64-ix-064", 04:20:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:20:52 INFO - "platform": "ubuntu64_hw", 04:20:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:20:52 INFO - "branch": "mozilla-aurora", 04:20:52 INFO - "repo_path": "releases/mozilla-aurora", 04:20:52 INFO - "revision": "b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f", 04:20:52 INFO - "stage_platform": "linux64-pgo", 04:20:52 INFO - "builduid": "3e330e94e72a44aabac68afc380e9ed1", 04:20:52 INFO - "slavebuilddir": "test" 04:20:52 INFO - } 04:20:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:20:52 INFO - Running post-action listener: _resource_record_post_action 04:20:52 INFO - ##### 04:20:52 INFO - ##### Running download-and-extract step. 04:20:52 INFO - ##### 04:20:52 INFO - Running pre-action listener: _resource_record_pre_action 04:20:52 INFO - Running main action method: download_and_extract 04:20:52 INFO - mkdir: /builds/slave/test/build/tests 04:20: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')]} 04:20:52 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:20:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:20:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:20:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:20:52 INFO - Downloaded 1361 bytes. 04:20:52 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:20:52 INFO - Using the following test package requirements: 04:20:52 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:20:52 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:20:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:20:52 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:20:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:20:52 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:20:52 INFO - u'jsshell-linux-x86_64.zip'], 04:20:52 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:20:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:20:52 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:20:52 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:20:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:20:52 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:20:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:20:52 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:20:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:20:52 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:20:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:20:52 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:20: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')]} 04:20:52 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:20:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:20:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:20:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:20:54 INFO - Downloaded 23799377 bytes. 04:20:54 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'] 04:20:54 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 04:20:55 INFO - Return code: 0 04:20:55 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 04:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:55 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:20:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:20:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:20:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:20:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:20:57 INFO - Downloaded 23799377 bytes. 04:20:57 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'] 04:20:57 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 04:20:58 INFO - Return code: 0 04:20: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')]} 04:20:58 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:20:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:20:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:20:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:20:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:20:59 INFO - Downloaded 10840145 bytes. 04:20:59 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'] 04:20:59 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 04:20:59 INFO - Return code: 0 04:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:59 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:20:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:20:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:20:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:20:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:01 INFO - Downloaded 62706998 bytes. 04:21:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:21:01 INFO - mkdir: /builds/slave/test/properties 04:21:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:21:01 INFO - Writing to file /builds/slave/test/properties/build_url 04:21:01 INFO - Contents: 04:21:01 INFO - build_url:https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:21:02 INFO - Running post-action listener: _resource_record_post_action 04:21:02 INFO - Running post-action listener: set_extra_try_arguments 04:21:02 INFO - ##### 04:21:02 INFO - ##### Running populate-webroot step. 04:21:02 INFO - ##### 04:21:02 INFO - Running pre-action listener: _resource_record_pre_action 04:21:02 INFO - Running main action method: populate_webroot 04:21:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:21:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:21:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:21:02 INFO - '--tppagecycles', 04:21:02 INFO - '7'], 04:21:02 INFO - 'tests': ['tsvgm']}}, 04:21:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:21:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:21:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:21:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:21:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:21:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:21:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:02 INFO - 'talos_options': ['--disable-e10s'], 04:21:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:02 INFO - 'talos_options': ['--disable-e10s'], 04:21:02 INFO - 'tests': ['damp', 'tps']}, 04:21:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:02 INFO - 'tests': ['damp', 'tps']}, 04:21:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:21:02 INFO - 'tests': ['dromaeo_dom']}, 04:21:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:21:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:21:02 INFO - 'tests': ['a11yr', 04:21:02 INFO - 'ts_paint', 04:21:02 INFO - 'tpaint', 04:21:02 INFO - 'sessionrestore', 04:21:02 INFO - 'sessionrestore_no_auto_restore', 04:21:02 INFO - 'tabpaint']}, 04:21:02 INFO - 'other-e10s': {'tests': ['a11yr', 04:21:02 INFO - 'ts_paint', 04:21:02 INFO - 'tpaint', 04:21:02 INFO - 'sessionrestore', 04:21:02 INFO - 'sessionrestore_no_auto_restore', 04:21:02 INFO - 'tabpaint']}, 04:21:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:21:02 INFO - 'ts_paint', 04:21:02 INFO - 'tpaint', 04:21:02 INFO - 'sessionrestore', 04:21:02 INFO - 'sessionrestore_no_auto_restore', 04:21:02 INFO - 'tabpaint']}, 04:21:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:21:02 INFO - 'ts_paint', 04:21:02 INFO - 'tpaint', 04:21:02 INFO - 'sessionrestore', 04:21:02 INFO - 'sessionrestore_no_auto_restore', 04:21:02 INFO - 'tabpaint']}, 04:21:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:21:02 INFO - 'tests': ['a11yr', 04:21:02 INFO - 'ts_paint', 04:21:02 INFO - 'tpaint', 04:21:02 INFO - 'sessionrestore', 04:21:02 INFO - 'sessionrestore_no_auto_restore', 04:21:02 INFO - 'tabpaint']}, 04:21:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:21:02 INFO - 'tests': ['a11yr', 04:21:02 INFO - 'ts_paint', 04:21:02 INFO - 'tpaint', 04:21:02 INFO - 'sessionrestore', 04:21:02 INFO - 'sessionrestore_no_auto_restore', 04:21:02 INFO - 'tabpaint']}, 04:21:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:21:02 INFO - 'tests': ['tsvgx', 04:21:02 INFO - 'tsvgr_opacity', 04:21:02 INFO - 'tart', 04:21:02 INFO - 'tscrollx', 04:21:02 INFO - 'cart']}, 04:21:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:21:02 INFO - 'tsvgr_opacity', 04:21:02 INFO - 'tart', 04:21:02 INFO - 'tscrollx', 04:21:02 INFO - 'cart']}, 04:21:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:02 INFO - 'talos_options': ['--disable-e10s'], 04:21:02 INFO - 'tests': ['tp5o']}, 04:21:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:02 INFO - 'tests': ['tp5o']}, 04:21:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:02 INFO - 'talos_options': ['--disable-e10s', 04:21:02 INFO - '--xperf_path', 04:21:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:02 INFO - 'tests': ['tp5n']}, 04:21:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:02 INFO - 'talos_options': ['--xperf_path', 04:21:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:02 INFO - 'tests': ['tp5n']}}, 04:21:02 INFO - 'talos.zip': {'path': '', 04:21:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:21:02 INFO - Running post-action listener: _resource_record_post_action 04:21:02 INFO - ##### 04:21:02 INFO - ##### Running create-virtualenv step. 04:21:02 INFO - ##### 04:21:02 INFO - Running pre-action listener: _resource_record_pre_action 04:21:02 INFO - Running main action method: create_virtualenv 04:21:02 INFO - Creating virtualenv /builds/slave/test/build/venv 04:21:02 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 04:21:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:21:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:21:02 INFO - Using real prefix '/usr' 04:21:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:21:02 INFO - Installing distribute.............................................................................................................................................................................................done. 04:21:04 INFO - Installing pip.................done. 04:21:04 INFO - Return code: 0 04:21:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:21:04 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')]} 04:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:04 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')]} 04:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:04 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 0x7f12771cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, '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 0x227e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', '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 04:21:04 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 04:21:04 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 04:21:04 INFO - Using env: {'DISPLAY': ':0', 04:21:04 INFO - 'HOME': '/home/cltbld', 04:21:04 INFO - 'LANG': 'en_US.UTF-8', 04:21:04 INFO - 'LANGUAGE': 'en_US:en', 04:21:04 INFO - 'LOGNAME': 'cltbld', 04:21:04 INFO - 'MAIL': '/var/mail/cltbld', 04:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:04 INFO - 'MOZ_NO_REMOTE': '1', 04:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:04 INFO - 'NO_EM_RESTART': '1', 04:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:04 INFO - 'PWD': '/builds/slave/test', 04:21:04 INFO - 'SHELL': '/bin/bash', 04:21:04 INFO - 'SHLVL': '1', 04:21:04 INFO - 'TERM': 'linux', 04:21:04 INFO - 'TMOUT': '86400', 04:21:04 INFO - 'USER': 'cltbld', 04:21:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', 04:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:04 INFO - '_': '/tools/buildbot/bin/python'} 04:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:04 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 04:21:04 INFO - Cleaning up... 04:21:04 INFO - Return code: 0 04:21:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:21:04 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')]} 04:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:04 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')]} 04:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:04 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 0x7f12771cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, '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 0x227e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', '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 04:21:04 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 04:21:04 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 04:21:04 INFO - Using env: {'DISPLAY': ':0', 04:21:04 INFO - 'HOME': '/home/cltbld', 04:21:04 INFO - 'LANG': 'en_US.UTF-8', 04:21:04 INFO - 'LANGUAGE': 'en_US:en', 04:21:04 INFO - 'LOGNAME': 'cltbld', 04:21:04 INFO - 'MAIL': '/var/mail/cltbld', 04:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:04 INFO - 'MOZ_NO_REMOTE': '1', 04:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:04 INFO - 'NO_EM_RESTART': '1', 04:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:04 INFO - 'PWD': '/builds/slave/test', 04:21:04 INFO - 'SHELL': '/bin/bash', 04:21:04 INFO - 'SHLVL': '1', 04:21:04 INFO - 'TERM': 'linux', 04:21:04 INFO - 'TMOUT': '86400', 04:21:04 INFO - 'USER': 'cltbld', 04:21:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', 04:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:04 INFO - '_': '/tools/buildbot/bin/python'} 04:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:05 INFO - Downloading/unpacking psutil>=0.7.1 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:21:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:07 INFO - Installing collected packages: psutil 04:21:07 INFO - Running setup.py install for psutil 04:21:07 INFO - building 'psutil._psutil_linux' extension 04:21:07 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 04:21:07 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 04:21:07 INFO - building 'psutil._psutil_posix' extension 04:21:07 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 04:21:07 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 04:21:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:07 INFO - Successfully installed psutil 04:21:07 INFO - Cleaning up... 04:21:07 INFO - Return code: 0 04:21:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:21: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')]} 04:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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')]} 04:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:07 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 0x7f12771cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, '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 0x227e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', '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 04:21:07 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 04:21:07 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 04:21:07 INFO - Using env: {'DISPLAY': ':0', 04:21:07 INFO - 'HOME': '/home/cltbld', 04:21:07 INFO - 'LANG': 'en_US.UTF-8', 04:21:07 INFO - 'LANGUAGE': 'en_US:en', 04:21:07 INFO - 'LOGNAME': 'cltbld', 04:21:07 INFO - 'MAIL': '/var/mail/cltbld', 04:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:07 INFO - 'MOZ_NO_REMOTE': '1', 04:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:07 INFO - 'NO_EM_RESTART': '1', 04:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:07 INFO - 'PWD': '/builds/slave/test', 04:21:07 INFO - 'SHELL': '/bin/bash', 04:21:07 INFO - 'SHLVL': '1', 04:21:07 INFO - 'TERM': 'linux', 04:21:07 INFO - 'TMOUT': '86400', 04:21:07 INFO - 'USER': 'cltbld', 04:21:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', 04:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:07 INFO - '_': '/tools/buildbot/bin/python'} 04:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:21:09 INFO - Installing collected packages: mozsystemmonitor 04:21:09 INFO - Running setup.py install for mozsystemmonitor 04:21:09 INFO - Successfully installed mozsystemmonitor 04:21:09 INFO - Cleaning up... 04:21:09 INFO - Return code: 0 04:21:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:09 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 0x7f12771cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, '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 0x227e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', '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 04:21:09 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 04:21:09 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 04:21:09 INFO - Using env: {'DISPLAY': ':0', 04:21:09 INFO - 'HOME': '/home/cltbld', 04:21:09 INFO - 'LANG': 'en_US.UTF-8', 04:21:09 INFO - 'LANGUAGE': 'en_US:en', 04:21:09 INFO - 'LOGNAME': 'cltbld', 04:21:09 INFO - 'MAIL': '/var/mail/cltbld', 04:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:09 INFO - 'MOZ_NO_REMOTE': '1', 04:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:09 INFO - 'NO_EM_RESTART': '1', 04:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:09 INFO - 'PWD': '/builds/slave/test', 04:21:09 INFO - 'SHELL': '/bin/bash', 04:21:09 INFO - 'SHLVL': '1', 04:21:09 INFO - 'TERM': 'linux', 04:21:09 INFO - 'TMOUT': '86400', 04:21:09 INFO - 'USER': 'cltbld', 04:21:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', 04:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:09 INFO - '_': '/tools/buildbot/bin/python'} 04:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:12 INFO - Downloading docopt-0.6.1.tar.gz 04:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:12 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:12 INFO - Running setup.py install for blobuploader 04:21:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:12 INFO - Running setup.py install for requests 04:21:13 INFO - Running setup.py install for docopt 04:21:13 INFO - Successfully installed blobuploader requests docopt 04:21:13 INFO - Cleaning up... 04:21:13 INFO - Return code: 0 04:21:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21: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')]} 04:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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')]} 04:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:13 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 0x7f12771cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, '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 0x227e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', '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 04:21:13 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 04:21:13 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 04:21:13 INFO - Using env: {'DISPLAY': ':0', 04:21:13 INFO - 'HOME': '/home/cltbld', 04:21:13 INFO - 'LANG': 'en_US.UTF-8', 04:21:13 INFO - 'LANGUAGE': 'en_US:en', 04:21:13 INFO - 'LOGNAME': 'cltbld', 04:21:13 INFO - 'MAIL': '/var/mail/cltbld', 04:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:13 INFO - 'MOZ_NO_REMOTE': '1', 04:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:13 INFO - 'NO_EM_RESTART': '1', 04:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:13 INFO - 'PWD': '/builds/slave/test', 04:21:13 INFO - 'SHELL': '/bin/bash', 04:21:13 INFO - 'SHLVL': '1', 04:21:13 INFO - 'TERM': 'linux', 04:21:13 INFO - 'TMOUT': '86400', 04:21:13 INFO - 'USER': 'cltbld', 04:21:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', 04:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:13 INFO - '_': '/tools/buildbot/bin/python'} 04:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:13 INFO - Running setup.py (path:/tmp/pip-toYVWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:13 INFO - Running setup.py (path:/tmp/pip-5U9Yo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:13 INFO - Running setup.py (path:/tmp/pip-J_T3Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:13 INFO - Running setup.py (path:/tmp/pip-WUywHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:13 INFO - Running setup.py (path:/tmp/pip-xXyTEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:13 INFO - Running setup.py (path:/tmp/pip-Pdf10i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:14 INFO - Running setup.py (path:/tmp/pip-5Lpy01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:14 INFO - Running setup.py (path:/tmp/pip-fy_ye5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:14 INFO - Running setup.py (path:/tmp/pip-_xnSoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:14 INFO - Running setup.py (path:/tmp/pip-g4yeiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:14 INFO - Running setup.py (path:/tmp/pip-XHNWSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:14 INFO - Running setup.py (path:/tmp/pip-to7wpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:14 INFO - Running setup.py (path:/tmp/pip-Au8S7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:14 INFO - Running setup.py (path:/tmp/pip-uSenwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:14 INFO - Running setup.py (path:/tmp/pip-C7KxlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:14 INFO - Running setup.py (path:/tmp/pip-IRxqJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:14 INFO - Running setup.py (path:/tmp/pip-XibYR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:14 INFO - Running setup.py install for manifestparser 04:21:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:14 INFO - Running setup.py install for mozcrash 04:21:15 INFO - Running setup.py install for mozdebug 04:21:15 INFO - Running setup.py install for mozdevice 04:21:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:15 INFO - Running setup.py install for mozfile 04:21:15 INFO - Running setup.py install for mozhttpd 04:21:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:15 INFO - Running setup.py install for mozinfo 04:21:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:15 INFO - Running setup.py install for mozInstall 04:21:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:15 INFO - Running setup.py install for mozleak 04:21:15 INFO - Running setup.py install for mozlog 04:21:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:15 INFO - Running setup.py install for moznetwork 04:21:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:16 INFO - Running setup.py install for mozprocess 04:21:16 INFO - Running setup.py install for mozprofile 04:21:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:16 INFO - Running setup.py install for mozrunner 04:21:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:16 INFO - Running setup.py install for mozscreenshot 04:21:16 INFO - Running setup.py install for moztest 04:21:16 INFO - Running setup.py install for mozversion 04:21:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:16 INFO - Cleaning up... 04:21:16 INFO - Return code: 0 04:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21: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')]} 04:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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')]} 04:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:16 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 0x7f12771cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, '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 0x227e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', '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 04:21:16 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 04:21:16 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 04:21:16 INFO - Using env: {'DISPLAY': ':0', 04:21:16 INFO - 'HOME': '/home/cltbld', 04:21:16 INFO - 'LANG': 'en_US.UTF-8', 04:21:16 INFO - 'LANGUAGE': 'en_US:en', 04:21:16 INFO - 'LOGNAME': 'cltbld', 04:21:16 INFO - 'MAIL': '/var/mail/cltbld', 04:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:16 INFO - 'MOZ_NO_REMOTE': '1', 04:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:16 INFO - 'NO_EM_RESTART': '1', 04:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:16 INFO - 'PWD': '/builds/slave/test', 04:21:16 INFO - 'SHELL': '/bin/bash', 04:21:16 INFO - 'SHLVL': '1', 04:21:16 INFO - 'TERM': 'linux', 04:21:16 INFO - 'TMOUT': '86400', 04:21:16 INFO - 'USER': 'cltbld', 04:21:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', 04:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:16 INFO - '_': '/tools/buildbot/bin/python'} 04:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:16 INFO - Running setup.py (path:/tmp/pip-esXIyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:16 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)) 04:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:16 INFO - Running setup.py (path:/tmp/pip-u279xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:17 INFO - Running setup.py (path:/tmp/pip-ttyHZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:17 INFO - Running setup.py (path:/tmp/pip-o1Z48Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:17 INFO - Running setup.py (path:/tmp/pip-8CpomA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:17 INFO - Running setup.py (path:/tmp/pip-r1Rk0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:17 INFO - Running setup.py (path:/tmp/pip-tta7nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:17 INFO - Running setup.py (path:/tmp/pip-IcpQQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:17 INFO - Running setup.py (path:/tmp/pip-3_qrYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:17 INFO - Running setup.py (path:/tmp/pip-UCmy1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:17 INFO - Running setup.py (path:/tmp/pip-5nigXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:17 INFO - Running setup.py (path:/tmp/pip-YH5HPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:17 INFO - Running setup.py (path:/tmp/pip-Kaugna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:17 INFO - Running setup.py (path:/tmp/pip-nX1y_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:17 INFO - Running setup.py (path:/tmp/pip-e11hfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:17 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)) 04:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:17 INFO - Running setup.py (path:/tmp/pip-1RhJjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:18 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)) 04:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:18 INFO - Running setup.py (path:/tmp/pip-n_T4XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:18 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)) 04:21:18 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)) 04:21:18 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)) 04:21:18 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)) 04:21:18 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)) 04:21:18 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)) 04:21:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:19 INFO - Downloading blessings-1.6.tar.gz 04:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:20 INFO - Installing collected packages: blessings 04:21:20 INFO - Running setup.py install for blessings 04:21:20 INFO - Successfully installed blessings 04:21:20 INFO - Cleaning up... 04:21:20 INFO - Return code: 0 04:21:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:20 INFO - Reading from file tmpfile_stdout 04:21:20 INFO - Current package versions: 04:21:20 INFO - argparse == 1.2.1 04:21:20 INFO - blessings == 1.6 04:21:20 INFO - blobuploader == 1.2.4 04:21:20 INFO - docopt == 0.6.1 04:21:20 INFO - manifestparser == 1.1 04:21:20 INFO - mozInstall == 1.12 04:21:20 INFO - mozcrash == 0.17 04:21:20 INFO - mozdebug == 0.1 04:21:20 INFO - mozdevice == 0.48 04:21:20 INFO - mozfile == 1.2 04:21:20 INFO - mozhttpd == 0.7 04:21:20 INFO - mozinfo == 0.9 04:21:20 INFO - mozleak == 0.1 04:21:20 INFO - mozlog == 3.1 04:21:20 INFO - moznetwork == 0.27 04:21:20 INFO - mozprocess == 0.22 04:21:20 INFO - mozprofile == 0.28 04:21:20 INFO - mozrunner == 6.11 04:21:20 INFO - mozscreenshot == 0.1 04:21:20 INFO - mozsystemmonitor == 0.0 04:21:20 INFO - moztest == 0.7 04:21:20 INFO - mozversion == 1.4 04:21:20 INFO - psutil == 3.1.1 04:21:20 INFO - requests == 1.2.3 04:21:20 INFO - wsgiref == 0.1.2 04:21:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:20 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')]} 04:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:20 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')]} 04:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:20 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 0x7f12771cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, '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 0x227e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', '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 04:21:20 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 04:21:20 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 04:21:20 INFO - Using env: {'DISPLAY': ':0', 04:21:20 INFO - 'HOME': '/home/cltbld', 04:21:20 INFO - 'LANG': 'en_US.UTF-8', 04:21:20 INFO - 'LANGUAGE': 'en_US:en', 04:21:20 INFO - 'LOGNAME': 'cltbld', 04:21:20 INFO - 'MAIL': '/var/mail/cltbld', 04:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:20 INFO - 'MOZ_NO_REMOTE': '1', 04:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:20 INFO - 'NO_EM_RESTART': '1', 04:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:20 INFO - 'PWD': '/builds/slave/test', 04:21:20 INFO - 'SHELL': '/bin/bash', 04:21:20 INFO - 'SHLVL': '1', 04:21:20 INFO - 'TERM': 'linux', 04:21:20 INFO - 'TMOUT': '86400', 04:21:20 INFO - 'USER': 'cltbld', 04:21:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', 04:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:20 INFO - '_': '/tools/buildbot/bin/python'} 04:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:20 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)) 04:21:20 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)) 04:21:20 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)) 04:21:20 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)) 04:21:20 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)) 04:21:20 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)) 04:21:20 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)) 04:21:20 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)) 04:21:20 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)) 04:21:20 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)) 04:21:20 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)) 04:21:20 INFO - Cleaning up... 04:21:20 INFO - Return code: 0 04:21:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:20 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')]} 04:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:20 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')]} 04:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:20 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 0x7f12771cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, '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 0x227e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', '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 04:21:20 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 04:21:20 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 04:21:20 INFO - Using env: {'DISPLAY': ':0', 04:21:20 INFO - 'HOME': '/home/cltbld', 04:21:20 INFO - 'LANG': 'en_US.UTF-8', 04:21:20 INFO - 'LANGUAGE': 'en_US:en', 04:21:20 INFO - 'LOGNAME': 'cltbld', 04:21:20 INFO - 'MAIL': '/var/mail/cltbld', 04:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:20 INFO - 'MOZ_NO_REMOTE': '1', 04:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:20 INFO - 'NO_EM_RESTART': '1', 04:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:20 INFO - 'PWD': '/builds/slave/test', 04:21:20 INFO - 'SHELL': '/bin/bash', 04:21:20 INFO - 'SHLVL': '1', 04:21:20 INFO - 'TERM': 'linux', 04:21:20 INFO - 'TMOUT': '86400', 04:21:20 INFO - 'USER': 'cltbld', 04:21:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', 04:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:20 INFO - '_': '/tools/buildbot/bin/python'} 04:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:20 INFO - Downloading/unpacking jsonschema 04:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:22 INFO - Downloading/unpacking functools32 (from jsonschema) 04:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:23 INFO - warning: no files found matching '*.txt' 04:21:23 INFO - no previously-included directories found matching 'build' 04:21:23 INFO - no previously-included directories found matching 'dist' 04:21:23 INFO - no previously-included directories found matching '.git*' 04:21:23 INFO - Installing collected packages: jsonschema, functools32 04:21:23 INFO - Running setup.py install for functools32 04:21:23 INFO - warning: no files found matching '*.txt' 04:21:23 INFO - no previously-included directories found matching 'build' 04:21:23 INFO - no previously-included directories found matching 'dist' 04:21:23 INFO - no previously-included directories found matching '.git*' 04:21:23 INFO - Successfully installed jsonschema functools32 04:21:23 INFO - Cleaning up... 04:21:23 INFO - Return code: 0 04:21:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:21:23 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')]} 04:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:23 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')]} 04:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:23 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 0x7f12771cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, '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 0x227e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', '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 04:21:23 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 04:21:23 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 04:21:23 INFO - Using env: {'DISPLAY': ':0', 04:21:23 INFO - 'HOME': '/home/cltbld', 04:21:23 INFO - 'LANG': 'en_US.UTF-8', 04:21:23 INFO - 'LANGUAGE': 'en_US:en', 04:21:23 INFO - 'LOGNAME': 'cltbld', 04:21:23 INFO - 'MAIL': '/var/mail/cltbld', 04:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:23 INFO - 'MOZ_NO_REMOTE': '1', 04:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:23 INFO - 'NO_EM_RESTART': '1', 04:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:23 INFO - 'PWD': '/builds/slave/test', 04:21:23 INFO - 'SHELL': '/bin/bash', 04:21:23 INFO - 'SHLVL': '1', 04:21:23 INFO - 'TERM': 'linux', 04:21:23 INFO - 'TMOUT': '86400', 04:21:23 INFO - 'USER': 'cltbld', 04:21:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', 04:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:23 INFO - '_': '/tools/buildbot/bin/python'} 04:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:23 INFO - Downloading/unpacking flake8 04:21:23 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 04:21:23 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 04:21:23 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 04:21:23 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 04:21:23 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 04:21:23 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 04:21:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:21:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:21:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:21:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:26 INFO - no previously-included directories found matching 'docs/_build' 04:21:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:21:26 INFO - Running setup.py install for pep8 04:21:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:26 INFO - no previously-included directories found matching 'docs/_build' 04:21:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:21:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:21:26 INFO - Cleaning up... 04:21:26 INFO - Return code: 0 04:21:26 INFO - Running post-action listener: _resource_record_post_action 04:21:26 INFO - Running post-action listener: _start_resource_monitoring 04:21:26 INFO - Starting resource monitoring. 04:21:26 INFO - ##### 04:21:26 INFO - ##### Running install step. 04:21:26 INFO - ##### 04:21:26 INFO - Running pre-action listener: _resource_record_pre_action 04:21:26 INFO - Running main action method: install 04:21:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:26 INFO - Reading from file tmpfile_stdout 04:21:26 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:26 INFO - Reading from file tmpfile_stdout 04:21:26 INFO - Output received: 04:21:26 INFO - Usage: mozinstall [options] installer 04:21:26 INFO - Options: 04:21:26 INFO - -h, --help show this help message and exit 04:21:26 INFO - -d DEST, --destination=DEST 04:21:26 INFO - Directory to install application into. [default: 04:21:26 INFO - "/builds/slave/test"] 04:21:26 INFO - --app=APP Application being installed. [default: firefox] 04:21:26 INFO - mkdir: /builds/slave/test/build/application 04:21:26 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'] 04:21:26 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 04:21:42 INFO - Reading from file tmpfile_stdout 04:21:42 INFO - Output received: 04:21:42 INFO - /builds/slave/test/build/application/firefox/firefox 04:21:42 INFO - Running post-action listener: _resource_record_post_action 04:21:42 INFO - ##### 04:21:42 INFO - ##### Running run-tests step. 04:21:42 INFO - ##### 04:21:42 INFO - Running pre-action listener: _resource_record_pre_action 04:21:42 INFO - Running main action method: run_tests 04:21:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:42 INFO - Python 2.7.3 04:21:42 INFO - Return code: 0 04:21:42 INFO - grabbing minidump binary from tooltool 04:21:42 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')]} 04:21:42 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 0x227d410>, '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 0x227e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:42 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 04:21:42 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 04:21:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:42 INFO - Return code: 0 04:21:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:21:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:21:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:21:43 INFO - Return code: 0 04:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:21:43 INFO - Using env: {'DISPLAY': ':0', 04:21:43 INFO - 'HOME': '/home/cltbld', 04:21:43 INFO - 'LANG': 'en_US.UTF-8', 04:21:43 INFO - 'LANGUAGE': 'en_US:en', 04:21:43 INFO - 'LOGNAME': 'cltbld', 04:21:43 INFO - 'MAIL': '/var/mail/cltbld', 04:21:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:43 INFO - 'MOZ_NO_REMOTE': '1', 04:21:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:43 INFO - 'NO_EM_RESTART': '1', 04:21:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:43 INFO - 'PWD': '/builds/slave/test', 04:21:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:43 INFO - 'SHELL': '/bin/bash', 04:21:43 INFO - 'SHLVL': '1', 04:21:43 INFO - 'TERM': 'linux', 04:21:43 INFO - 'TMOUT': '86400', 04:21:43 INFO - 'USER': 'cltbld', 04:21:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313', 04:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:43 INFO - '_': '/tools/buildbot/bin/python'} 04:21:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:21:43 INFO - mozversion application_buildid: 20160506013623 04:21:43 INFO - mozversion application_changeset: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f 04:21:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:21:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:43 INFO - mozversion application_name: Firefox 04:21:43 INFO - mozversion application_remotingname: firefox-dev 04:21:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:21:43 INFO - mozversion application_vendor: Mozilla 04:21:43 INFO - mozversion application_version: 48.0a2 04:21:43 INFO - mozversion platform_buildid: 20160506013623 04:21:43 INFO - mozversion platform_changeset: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f 04:21:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:21:43 INFO - mozversion platform_version: 48.0a2 04:21:43 INFO - using testdate: 1462533703 04:21:43 INFO - actual date: 1462533703 04:21:43 INFO - starting webserver on 'localhost:47177' 04:21:43 INFO - SUITE-START | Running 2 tests 04:21:43 INFO - TEST-START | dromaeo_css 04:21:43 INFO - operating with platform_type : linux_ 04:21:43 INFO - Initialising browser for dromaeo_css test... 04:21:43 INFO - TEST-INFO | started process 18419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBaW0Mo/profile http://localhost:47177/getInfo.html) 04:21:47 INFO - PROCESS | 18419 | __metrics Screen width/height:1600/1200 04:21:47 INFO - PROCESS | 18419 | colorDepth:24 04:21:47 INFO - PROCESS | 18419 | Browser inner width/height: 1024/697 04:21:47 INFO - PROCESS | 18419 | __metrics 04:21:48 ERROR - PROCESS | 18419 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:21:49 INFO - TEST-INFO | 18419: exit 0 04:21:49 INFO - Browser initialized. 04:21:49 INFO - Running cycle 1/1 for dromaeo_css test... 04:21:49 INFO - TEST-INFO | started process 18509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBaW0Mo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:01 INFO - PROCESS | 18509 | RSS: Main: 141869056 04:22:01 INFO - PROCESS | 18509 | 04:22:52 INFO - PROCESS | 18509 | 1462533772553 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] 04:25:00 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:47177/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47177/tests/dromaeo/cssquery-ext.html) 04:25:01 INFO - PROCESS | 18509 | RSS: Main: 250798080 04:25:01 INFO - PROCESS | 18509 | 04:28:03 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:47177/tests/dromaeo/cssquery-ext.html (next: http://localhost:47177/tests/dromaeo/cssquery-jquery.html) 04:28:03 INFO - PROCESS | 18509 | RSS: Main: 220291072 04:28:03 INFO - PROCESS | 18509 | 04:31:05 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:47177/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47177/tests/dromaeo/cssquery-mootools.html) 04:31:06 INFO - PROCESS | 18509 | RSS: Main: 236392448 04:31:06 INFO - PROCESS | 18509 | 04:34:08 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:47177/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47177/tests/dromaeo/cssquery-prototype.html) 04:34:08 INFO - PROCESS | 18509 | RSS: Main: 223477760 04:34:08 INFO - PROCESS | 18509 | 04:37:11 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:47177/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47177/tests/dromaeo/cssquery-yui.html) 04:37:11 INFO - PROCESS | 18509 | RSS: Main: 212131840 04:37:11 INFO - PROCESS | 18509 | 04:40:14 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:47177/tests/dromaeo/cssquery-yui.html (next: http://localhost:47177/tests/dromaeo/cssquery-dojo.html) 04:40:14 INFO - PROCESS | 18509 | RSS: Main: 251793408 04:40:14 INFO - PROCESS | 18509 | 04:40:14 INFO - PROCESS | 18509 | __start_tp_report 04:40:14 INFO - PROCESS | 18509 | _x_x_mozilla_page_load 04:40:14 INFO - PROCESS | 18509 | _x_x_mozilla_page_load_details 04:40:14 INFO - PROCESS | 18509 | |i|pagename|runs| 04:40:14 INFO - PROCESS | 18509 | |0;dojo.html;3249.756268279879;3337.716294115002;3346.7657263991523;3363.377775111603;3383.3064221834525;5500.147477141039;5501.697406642633;5546.417626149257;5549.2231087647715;5576.776928922848;5556.499915007648;5577.330720313558;5588.636738611997;5600.52395546379;5622.269105016352;4952.380952380952;5045.722485263327;5056.089903817302;5124.692518448886;5197.974010129944;5057.620678449131;5111.974440127794;5118.6416950813455;5119.308893299412;5122.871928201806;5000.97499512502;5052.444231134572;5065.848024559269;5077.64456488046;5102.872428189306;5134.409542902558;5155.432902380735;5166.095933211673;5172.974135129338;5204.453532379083;4908.7300198489065;4974.726390048546;5061.089003979319;5081.187010078406;5089.974550127263;5450.618456708032;5453.727313634342;5487.42382049883;5497.587680923947;5505.779768809243;5930.822075337746;5930.822075337746;5932.3474417814;5932.902413053599;5933.703314834284;5924.644521328734;5953.8809223815715;5983.252093488314;5988.700564971778;6022.759089636453;5585.622434269942;5610.298712660918;5632.352279487829;5632.464915832989;5634.098544232903;5935.584509084322;6131.399973055325;6139.293981192131;6144.569880108439;6145.877082458326;5743.310802703619;5818.5345172386105;5818.679972601548;5820.447057529528;5837.445442682938;5941.138534912414;5948.910766338508;5953.136795164677;5958.314793798769;5967.433093856077;5755.740991655385;5787.450192231731;5935.821925342247;5946.524278057745;5954.136650185786;5868.501177399969;5871.060630299217;5879.323877754027;5884.058550631964;5911.733971971272;4476.350929115325;4477.574630410106;4482.8206871725415;4493.7977790999485;4507.932381014288;3962.2075584883137;4017.5178978522763;4031.7984100794843;4063.674906007512;4098.754074755524;5663.858403539944;5679.659220446786;5680.11958146488;5682.289713785777;5683.857903552362;5968.522518198533;5971.701414929236;5991;5992.041273396236;5992.790252341234;5412.729363531807;5604.215409842625;5645.717714114277;5729.427057294321;5747.08046712524;5090.541851233333;5117.41149767774;5117.8464646060675;5123.205903085028;5129.897402051938;6134.938650613526;6186.443220110212;6189.96905015481;6191.349908259568;6192.566520343623;5850.531957443309;5880.8235752927485;5962.522998160223;5982.641041537521;6000.309964354155;6134.693265336805;6135.723892424762;6138.969305153446;6142.262928448615;6153.569250152446;5750.338711048115;5829.5336373090895;5835.67903765297;5838.591298609056;5840.532757379485;5908.3500814911185;5930;5946.464818166386;5958.880822383441;5964.910526342195;5801.622894511843;5816.214811000461;5832.270966129234;5836.620619659709;5841.299044114733;5650.208970744017;5705.087186050212;5721.656700597978;5767.192593037062;5772.855678608068;5669.603127781016;5671.17767923657;5682.9431705684065;5688.63023903445;5721.1990321354215;5793.768249269982;5803.709814509342;5804.738786754522;5805.506531944832;5816.94183058164;5582.246396736388;5690.3456102548735;5750.223719797774;5761.251037365116;5829.417058294137 04:40:14 INFO - PROCESS | 18509 | |1;ext.html;619.5198720991232;660.389140045458;666.5434177588351;677.9050932869399;755.6863901480885;40314.39528407073;41054.38418423722;41132.383014254774;41152.58847411525;41173;44922.32616510755;45651;45756.54243457573;45773.54226457734;45802.77098614502;8214.589270536479;8793.824123517526;8982.146696063863;10328.173746100294;10487.423191724452;10380.169586433105;10522;10529.2103092268;10534.315269507457;10537.36775793451;10480.109190718798;10560.577576896952;10562.735931601734;10565.049145576897;10569.10162636177;8401.53791541465;10313.89686103137;10493.842592361121;10496.265261431703;10500.529925810393;10474.162067034618;10579.68260952165;10581.470926453647;10581.84127238092;10584.841227381596;41527.7923610383;42155.36766948467;42294.78852605717;42327.57672423298;42329.1534169318;3727.925441491182;3802.258559580883;3802.8098595070414;3806.1816709407613;3869.090763670535;35370.29259414797;35617.643823561695;35812.64187358119;35862;36029.81985090084;4445.355423463579;4524.47968483622;4536.56902594253;4593.609543188833;4595.103954728829;330163;331221;335014;335168.3241583801;335308;40797;41664;68572.657136714;69084.6545767268;69103.23587056462;39561;39659.80170099131;39749.80125099356;39776.40335394971;39817.40273895894;15117.395304187708;17320.220590073477;17495.387661432043;17497;17517.824821751874;12514.249145051326;12649.620511384674;14785.778213326808;15248.542543723706;15271.236438178046;9505.952470237604;9513.238940884712;9542.33203675736;9617.663381781604;9625.229981601455;3664.871729489455;3669.522962014921;3694.907627309285;3737.0844143185095;3772.660460558563;1110.8333749937574;1121.9623888739663;1131.332513816852;1204.933728644933;1234.8086046662781;34008.31983360319;34088.834120763655;34736;34849.65150348515;34981.65018349784;1187.8693343732182;1262.5391732017931;1285.4344088600985;1295.9676008099684;1332.1341128266704;17508.299668013136;17799.644007119787;17848.46454606364;17855.196516156804;18360.173792179383;488427;494441;496017;496836;496857;63681.68159159175;64883.67558162179;64892;64957;64970.675146623966;1407.0572716280117;1464.8681618654373;1485.4281101775678;1508.2835653064706;1595.226315237109;30629;31639.367212655157;32271.51592726158;32357.676423235465;32718.34563308673;45811.31283030824;45936.54063459457;45951;46050.30924536202;46234.768826155654;288248;289488;289668;289920;290512;28673.713262867106;31431.685683142874;31778.364432711678;31959.201019974687;32119.51820722738;47334.28998565093;49881.75059124681;50287.74856125696;51121;51700.741496293784;41336.793316033225;41696;41854;41955.37066943937;42846.571534285504;39978.497620802395;41626.37560436656;41636.58363416327;43541.78229108834;43904.78047609742;40127.79936100301;40390;40735.59264407318;40853.59146408617;41264.587354127274;34458.31083378368;35307.646923531465;35582.28835423225;35856.10359741027;36157.81921090378;27859.44281114407;27937.720622793513;27952;28213.294667632654;28420.85789571039 04:40:14 INFO - PROCESS | 18509 | |2;jquery.html;417.1698320342517;418.41213095600693;419.71039982412117;428.56714718134685;429.5446826364054;18524.166412511437;18992.43022709319;19017.144228509733;19863.702044469308;20282.188712451483;19421.417357479262;20130;20139.194432222732;20174.293899713513;20459.386218413434;5886.558508111887;5997.580169388145;6027.819165425044;6030.9396906030815;6064.696765161746;5870.88258234835;5987.820365389045;5998.9700051499685;6003.249593800775;6012.278526576817;5774.249347584808;5915.467607915287;5974.283086029683;5977.043673012319;6002.759889604433;5884.705764711747;5904.409559044104;5906.527477801766;5907.291125064999;5911.970440147815;5290.709011004393;5306.548943339821;5334.466553344673;5382.784688612451;5386.757595908193;23078.884605577034;23191;23534.764652353428;23586.528269434515;23632.645510317358;2483.75162483752;2552.923412297634;2615.137004788415;2674.4517373938297;2992.2070651277427;8086.838263234761;11485.94257028718;15131.848681513155;15184.316705748268;15477.613059673486;2052.7126202331688;2069.224040984631;2079.12676675795;2082.2607974169105;2155.504234026183;79656.20343796603;81064.59467702742;81133.59433202796;83224;84181.15818841856;10751.83872241917;10800.297980631234;10951.4524273786;11151.553937842558;11284;15605.68788624221;15741.763873541906;15813.841861581466;15824.367025318857;15844.44544440962;8722.65109395617;8783.165599268059;8870.64517419296;8924.375293729507;8948.373613847098;8797.252233560219;8800.911990880137;8925.955370223108;8946.68686595966;8967.775805604912;6853.862922741518;6913.827154321081;6919.858223393084;7009.684564194624;7070.858582828315;1955.2960934063726;1963.6661767499559;1971.1721077147633;2005.2680771518292;2010.1858747207405;1056.27645063132;1136.017344996572;1164.4876254448186;1178.4461303187488;1199.7600479904054;18913.43259702211;19418.126184321456;19507.512312192026;19526.414207573795;19759.308424205083;1037.3205550364523;1065.142560239015;1103.536514663843;1103.7020004598714;1167.258790667915;10708.89291107079;10902.345859248471;10957.452127393757;11038.503267352988;11077.169212309109;530419;538445;545123;554040;563845;96614;96687.03312966922;97907.51046244723;99486;100495.49752251338;1137.5108703257679;1150.6260465348796;1151.9193656443967;1155.5320095361392;1167.9708007299716;17077.829221707623;17637.470875873743;17718.557036074202;17808.46574602764;17840.821591783915;40391;40652.3902141474;40898.1820363597;41497;42262.366064508446;56849.715751420976;58794.7060264696;59075.409245906994;59106;59328.110078349724;9240.630374785202;9254.768630784285;9307.20888724466;9355.298352623444;9415.952920235355;13208.603741887759;13287.734245315232;13623.18260904349;14230.217338046506;14258.861170824459;12189.451474683483;12207.450664720287;12234.938825305817;12367.814482782946;12590.559330423757;11820.881791181979;12007.75984480323;12291.262524248574;12317.692057698629;12405;12154.209976351509;12345.876541234831;12382.81425778596;12499.500019999097;12825.807612886001;9110.407823491452;9111.544422778967;9148.176664100263;9207.86188207164;9248.21390181842;8876.733697989072;11364.659060228207;11985.460654270404;12141.817872731739;12158.331291779037 04:40:14 INFO - PROCESS | 18509 | |3;mootools.html;1494.559105064006;1509.6905134447438;1540.3453532248795;1743.7733094697687;1914.6457905287523;7661.348785353245;8400.747977560668;8560.657573697044;8579.571021448934;8586.398952073358;8348.16518348165;8497.235248827605;8560.143985601437;8570.57147142642;8588.484690918534;2121.52265740208;2358.690926535772;2377.892994815233;2396.424858034068;2413.722421921475;2380.381100913766;2387.570237357275;2393.74865639108;2396.3529846941315;2396.7123945126523;2327.9883600582057;2380.702412198475;2383.1063351243283;2390.880455977203;2395.377201927494;2072.533679922013;2299.942501437469;2339.4034521197073;2341.4965782356876;2350.0247397330086;2290.129750694742;2325.104834638659;2337.322176568793;2339.0643742502966;2357.54027964547;8436.240738333518;8472.957635211846;8475.449095808754;8503.149685031509;8514.957425212835;5222.660527065728;5278.894422111536;5331.946680533222;5334.226537152092;5379.38137114233;3267.803931764078;3296.307775367176;3366.2762506061313;3593.7843729376323;3670.5778835434;1158.8551431071116;1162.6628277799427;1181.8345431639577;1208.3233389301931;1214.0712355048395;12275.140740148194;12330.136890417674;12339.444724987306;12347.073969452327;12372.56696015644;4603.49361570227;4677.555632214934;4735.052989402134;4749.881252968635;4823.782929768169;10397.168226541859;10412.895871041344;10418.583256669799;10435.32170408921;10436.112930401001;4967.105920934267;5458.727063646802;5472.480114389126;5475.616706830563;5486.231927530149;4943.9258411123865;4956.033573453142;4996.675216110941;5007.1988481843455;5017.874553136201;4011.097503061846;4015.231899723313;4087.1008378156757;4120.320147175742;4132.8140233689555;1318.5780550224029;1335.7128217433299;1342.731453709262;1348.3595292236305;1355.979660305096;983.8376667849725;1016.8017236638932;1031.489412740698;1044.9947750261351;1045.341434896026;5707.143928410688;5784.479396854219;5788.565857560699;5827.970860145672;5948.910766338508;450.3582395087053;455.83362072843175;462.1911654604442;463.9698419602715;465.83230037186587;3918.626890881576;3963.3460479020637;3985.4818873546255;3995.680345572347;4017.7991100445447;10503.737406564896;10806.675799726021;10927.945360273148;10947.616833410792;10951;10115.544800483996;10411.53148108337;10690.305130166515;10811.35131892089;10812.729681758019;8079.1516890725625;8144.185581441809;8183.795405114801;8244.175582441709;8277.130901255401;5545.195946587803;5763.648445423678;5765.942340576708;5832.300123985149;5883.61756485827;9640;9661.806763864824;9754.268429867647;9860.359076659994;9898.901010990086;9539.523023848918;9803.607855685692;9973.351732137387;10016.64941727036;10018.799624007625;7070;7441.293077157661;7508.324250817234;7820.296173344426;7922.247386498273;8034.558099304594;8048.718294859652;8068.072171700095;8083.636236369495;8099.716509922125;7242.96378518104;7409.444291678038;7454.813629659302;7458.254174582498;7562.2059683734615;7249.238829922782;7307.5980821055355;7318.085239345082;7382.187959324363;7397.741079062207;6638.601683898982;6680.098186744727;6828.283030281749;6914.792556223321;6953.374196322356;4861.149298872612;5056.898862022813;5089.491050894881;5101.183810590288;5125.92311115341;4902.362692849907;4938.506149385033;4961.875953101201;4995;5058.9494105058475 04:40:14 INFO - PROCESS | 18509 | |4;prototype.html;331.72798305389574;332.836909914142;333.2734638488095;350.5880590306391;351.87684310491346;6193.38066193381;6229.345918678536;6261.53038522111;6274.811755647326;6285.214348206474;6213.627182369061;6219.129321894939;6237.937620623792;6240.469560087398;6262.780802671908;4557.977210113945;4645.210314246586;4718.4337879454515;4730.90538189236;4745.477997420281;4730.266808644666;4738.8341408050555;4744.264638980963;4768.070226305872;4768.523147685239;4543.568361005699;4710.693804902688;4721.763911804396;4728.078024785168;4741.459025816606;4592.288195329729;4704.1767690654;4732.100900828831;4738.786754596052;4751.501092385284;4141.6065473779945;4153.7507749535125;4156.04410985472;4161.292580261333;4175.519815221258;5933.258342707161;5950.196723442366;5962.850928726816;5965.761369545213;5971.940280597182;5469.562435005229;5472.20653005312;5472.26124473195;5477.5070243677865;5483;6377.521685873532;6473.190851143607;6480.092787009822;6498.772542960974;6503.674816259216;4592.609628181609;4597.356370108188;4607.493175750665;4610.193216187154;4623.052274283764;6759.628220447873;6804.489663275274;6806.7957961261245;6818.795436136924;6819.488538359643;4705.60002399793;4708.270218116198;4711.95288047122;4712.104700106968;4716.033213191287;4779.689320194177;4781.880452988634;4783.736894470838;4786.736729479842;4787.54518320759;5467.9453205468235;5474.835754927359;5480.287562616834;5489.890202195934;5490.615656904059;6417.871642567123;6514.934850651528;6588.110605068255;6619.437347825488;6628.105205797156;1683.5033665068834;1688.3077938045342;1698.7791587093598;1700.5578549577199;1701.7617533545313;1069.7539565899888;1097.2209731091016;1117.223529646904;1148.7989601819647;1157.9247348922293;6338.58799178052;6344.048392741126;6348.809535713936;6348.904766428507;6349.015902535022;6730.9326906731285;6747.493937954673;6750.32496750321;6752.189737231563;6763.797086087426;6325.209348831396;6330.620162790247;6336.081268216083;6341.23905131378;6344.873102537924;3606.6573675500786;3636.6726994570085;3645.671889529955;3653;3656.524651795303;6845.5550389224545;6991.510594258455;7011.1586609607175;7020.719171233093;7023.89464158038;6834.453243740489;6837.863242735118;6843.555168914005;6855.348741869514;6864;6913.1358580177475;6930;6936.2023367312395;6936.445084393236;6999.930000700029;6706.497012723968;6717.731290748316;6718.428933540704;6727.93272067273;6729.427998619976;6482.060101285381;6593.80218593443;6615.140031795836;6622.768203112868;6639.136912201383;6916.6166766645865;6934.479914006571;6941.409980151744;6966.895496567454;6971.407430368476;4767.332573439652;4768.3085952537385;4778.1399348117675;4787.832425865078;4801.159797035435;6702.597844129368;6704.564203326768;6716.966415167893;6719.428848547733;6724.596524208368;6331.810045698637;6497.675116244263;6539.901901471387;6548.443382312556;6560.475161987125;6463.062855885776;6496.317886621837;6496.317886622026;6499.28507864144;6507.414332710079;6386.584871983307;6402.03969404593;6414.294427613052;6415.454686351526;6436.485081193399;6538.673066346759;6564.442022427956;6572.244191917991;6573.1783527059115;6581.835454113494;6185.84535386619;6425.742970281136;6428.646424446513;6434.163558737334;6577.309382514767 04:40:14 INFO - PROCESS | 18509 | |5;yui.html;897.5063714956774;899.2715900120904;909.5906841921133;923.2291036984122;930.7486978515805;14809.777853332209;14814.407423703053;15148.697026059499;15149.318280677368;15167.848321516782;13863.168209907413;14173.43306267748;14217.786733198984;14226;14240.287985600731;744.3896005275649;871.7036207689384;880.0495464897895;881.2597418168737;895.2524641923969;875.588473417496;877.3902138014083;878.1174919206189;878.7846977490524;879.2614204068581;921.6543796076471;923.8937522184967;924.431474643093;925.2413021322518;927.2859897878664;787.8503084413971;794.2653045932518;886.8758373827669;914.063085337531;918.2929144558719;668.3683918696834;669.6651674162919;669.7354544954716;670.1991120610872;671.0370618162902;13706.177629342172;13755.587332379944;13758.93120534401;13766.793498097537;13804.240766757825;13495.932520337434;13613.455461781517;13895.374708138159;14323.498677546237;14501.56495305132;12062.879371206263;12111.818322725167;12210.511579536807;12246.938765306117;12335.013198944063;3926.8625598104213;3989.1024519483176;4001.379786133154;4045.0696339841707;4071.877843664695;52445;52509.2123618146;53770.731146344406;53818;53854.19218711722;11483.712907177387;11590.826137607943;11601.883981160248;11629.24409913353;11995.76008479843;19781.60436791256;19826.60346793056;20031.39905802828;20086.899565502077;20096.69854952177;8543.700970466003;8671.913280867111;8831.161039701217;8922.86615700765;8956.373053886296;5070.61970352225;5078.5937125029905;5139.948600513947;5163.974180129076;5308.973455132699;3525.294941011808;3577.964220357763;3582.8566857325936;3583.211693427442;3586.7847929124337;657.1850904877917;661.6691654172913;693.0747452151435;711.4486273138256;712.7754757251449;573.0487390931034;714.0328395270996;716.3982254905904;729.6825880741894;758.4463341760436;8569.95715021421;9033.77415564616;9249.861252081224;9307.76730581741;9369.953150234342;686.306830101591;686.5125760709852;729.2270193594807;775.3022279948092;802.3861745764494;4081.9591804082174;4160.355144952538;4233.364995250676;4261.594994537653;4393.978030109829;55265.44734552683;55344.446555534734;61526.69236653788;61621;61973.690131549054;52129.47870521322;52973;53080.203796943075;53955.730221349426;54022.45977540253;47921.28118078232;48228.5177148224;48690;48983;49072;8854.335924805537;8928.375013749235;8939.150780675825;8996.370254082152;9007.324450666096;35775;36820.81589592035;37811.243775123796;38176.23647526978;38786.80606596949;48414.75792621014;48868.5113148864;49608;50525;50847;11590.94204528972;11751.706207344885;11794;11866.703332416413;11998.520059197534;14058.297085145497;14316.212608306643;14665.266736663338;14792.11247325164;15042.924785376003;12952.158109722837;13134;13140.211587304791;13356.131851429625;13833.377498012815;13424.127431716906;13540.137296138933;13650.658733531742;13754.243516606683;14039.929800350932;12375.133740638428;12941;12980.339030498537;13087.41106650184;13310.401031953392;10342.638007669695;10532;10811.675649730521;10932.344059356465;10938.56245750161;10835.620753273914;10902.236843420884;11217.990380865434;11284.266522676;11302 04:40:14 INFO - PROCESS | 18509 | __end_tp_report 04:40:14 INFO - PROCESS | 18509 | __start_cc_report 04:40:14 INFO - PROCESS | 18509 | _x_x_mozilla_cycle_collect,841 04:40:14 INFO - PROCESS | 18509 | __end_cc_report 04:40:14 INFO - PROCESS | 18509 | __startTimestamp1462534814302__endTimestamp 04:40:14 INFO - PROCESS | 18509 | 04:40:14 INFO - PROCESS | 18509 | ------- Summary: start ------- 04:40:14 INFO - PROCESS | 18509 | Number of tests: 6 04:40:14 INFO - PROCESS | 18509 | 04:40:14 INFO - PROCESS | 18509 | [#0] dojo.html Cycles:165 Average:5521.89 Median:5721.66 stddev:611.80 (10.7%) stddev-sans-first:587.14 04:40:14 INFO - PROCESS | 18509 | Values: 3249.8 3337.7 3346.8 3363.4 3383.3 5500.1 5501.7 5546.4 5549.2 5576.8 5556.5 5577.3 5588.6 5600.5 5622.3 4952.4 5045.7 5056.1 5124.7 5198.0 5057.6 5112.0 5118.6 5119.3 5122.9 5001.0 5052.4 5065.8 5077.6 5102.9 5134.4 5155.4 5166.1 5173.0 5204.5 4908.7 4974.7 5061.1 5081.2 5090.0 5450.6 5453.7 5487.4 5497.6 5505.8 5930.8 5930.8 5932.3 5932.9 5933.7 5924.6 5953.9 5983.3 5988.7 6022.8 5585.6 5610.3 5632.4 5632.5 5634.1 5935.6 6131.4 6139.3 6144.6 6145.9 5743.3 5818.5 5818.7 5820.4 5837.4 5941.1 5948.9 5953.1 5958.3 5967.4 5755.7 5787.5 5935.8 5946.5 5954.1 5868.5 5871.1 5879.3 5884.1 5911.7 4476.4 4477.6 4482.8 4493.8 4507.9 3962.2 4017.5 4031.8 4063.7 4098.8 5663.9 5679.7 5680.1 5682.3 5683.9 5968.5 5971.7 5991.0 5992.0 5992.8 5412.7 5604.2 5645.7 5729.4 5747.1 5090.5 5117.4 5117.8 5123.2 5129.9 6134.9 6186.4 6190.0 6191.3 6192.6 5850.5 5880.8 5962.5 5982.6 6000.3 6134.7 6135.7 6139.0 6142.3 6153.6 5750.3 5829.5 5835.7 5838.6 5840.5 5908.4 5930.0 5946.5 5958.9 5964.9 5801.6 5816.2 5832.3 5836.6 5841.3 5650.2 5705.1 5721.7 5767.2 5772.9 5669.6 5671.2 5682.9 5688.6 5721.2 5793.8 5803.7 5804.7 5805.5 5816.9 5582.2 5690.3 5750.2 5761.3 5829.4 04:40:14 INFO - PROCESS | 18509 | 04:40:14 INFO - PROCESS | 18509 | [#1] ext.html Cycles:180 Average:54230.36 Median:19911.35 stddev:101152.86 (508.0%) stddev-sans-first:101356.53 04:40:14 INFO - PROCESS | 18509 | Values: 619.5 660.4 666.5 677.9 755.7 40314.4 41054.4 41132.4 41152.6 41173.0 44922.3 45651.0 45756.5 45773.5 45802.8 8214.6 8793.8 8982.1 10328.2 10487.4 10380.2 10522.0 10529.2 10534.3 10537.4 10480.1 10560.6 10562.7 10565.0 10569.1 8401.5 10313.9 10493.8 10496.3 10500.5 10474.2 10579.7 10581.5 10581.8 10584.8 41527.8 42155.4 42294.8 42327.6 42329.2 3727.9 3802.3 3802.8 3806.2 3869.1 35370.3 35617.6 35812.6 35862.0 36029.8 4445.4 4524.5 4536.6 4593.6 4595.1 330163.0 331221.0 335014.0 335168.3 335308.0 40797.0 41664.0 68572.7 69084.7 69103.2 39561.0 39659.8 39749.8 39776.4 39817.4 15117.4 17320.2 17495.4 17497.0 17517.8 12514.2 12649.6 14785.8 15248.5 15271.2 9506.0 9513.2 9542.3 9617.7 9625.2 3664.9 3669.5 3694.9 3737.1 3772.7 1110.8 1122.0 1131.3 1204.9 1234.8 34008.3 34088.8 34736.0 34849.7 34981.7 1187.9 1262.5 1285.4 1296.0 1332.1 17508.3 17799.6 17848.5 17855.2 18360.2 488427.0 494441.0 496017.0 496836.0 496857.0 63681.7 64883.7 64892.0 64957.0 64970.7 1407.1 1464.9 1485.4 1508.3 1595.2 30629.0 31639.4 32271.5 32357.7 32718.3 45811.3 45936.5 45951.0 46050.3 46234.8 288248.0 289488.0 289668.0 289920.0 290512.0 28673.7 31431.7 31778.4 31959.2 32119.5 47334.3 49881.8 50287.7 51121.0 51700.7 41336.8 41696.0 41854.0 41955.4 42846.6 39978.5 41626.4 41636.6 43541.8 43904.8 40127.8 40390.0 40735.6 40853.6 41264.6 34458.3 35307.6 35582.3 35856.1 36157.8 27859.4 27937.7 27952.0 28213.3 28420.9 04:40:14 INFO - PROCESS | 18509 | 04:40:14 INFO - PROCESS | 18509 | [#2] jquery.html Cycles:180 Average:31157.54 Median:23362.88 stddev:89881.91 (384.7%) stddev-sans-first:90104.41 04:40:14 INFO - PROCESS | 18509 | Values: 417.2 418.4 419.7 428.6 429.5 18524.2 18992.4 19017.1 19863.7 20282.2 19421.4 20130.0 20139.2 20174.3 20459.4 5886.6 5997.6 6027.8 6030.9 6064.7 5870.9 5987.8 5999.0 6003.2 6012.3 5774.2 5915.5 5974.3 5977.0 6002.8 5884.7 5904.4 5906.5 5907.3 5912.0 5290.7 5306.5 5334.5 5382.8 5386.8 23078.9 23191.0 23534.8 23586.5 23632.6 2483.8 2552.9 2615.1 2674.5 2992.2 8086.8 11485.9 15131.8 15184.3 15477.6 2052.7 2069.2 2079.1 2082.3 2155.5 79656.2 81064.6 81133.6 83224.0 84181.2 10751.8 10800.3 10951.5 11151.6 11284.0 15605.7 15741.8 15813.8 15824.4 15844.4 8722.7 8783.2 8870.6 8924.4 8948.4 8797.3 8800.9 8926.0 8946.7 8967.8 6853.9 6913.8 6919.9 7009.7 7070.9 1955.3 1963.7 1971.2 2005.3 2010.2 1056.3 1136.0 1164.5 1178.4 1199.8 18913.4 19418.1 19507.5 19526.4 19759.3 1037.3 1065.1 1103.5 1103.7 1167.3 10708.9 10902.3 10957.5 11038.5 11077.2 530419.0 538445.0 545123.0 554040.0 563845.0 96614.0 96687.0 97907.5 99486.0 100495.5 1137.5 1150.6 1151.9 1155.5 1168.0 17077.8 17637.5 17718.6 17808.5 17840.8 40391.0 40652.4 40898.2 41497.0 42262.4 56849.7 58794.7 59075.4 59106.0 59328.1 9240.6 9254.8 9307.2 9355.3 9416.0 13208.6 13287.7 13623.2 14230.2 14258.9 12189.5 12207.5 12234.9 12367.8 12590.6 11820.9 12007.8 12291.3 12317.7 12405.0 12154.2 12345.9 12382.8 12499.5 12825.8 9110.4 9111.5 9148.2 9207.9 9248.2 8876.7 11364.7 11985.5 12141.8 12158.3 04:40:14 INFO - PROCESS | 18509 | 04:40:14 INFO - PROCESS | 18509 | [#3] mootools.html Cycles:180 Average:5703.30 Median:4842.47 stddev:3217.12 (66.4%) stddev-sans-first:3210.60 04:40:14 INFO - PROCESS | 18509 | Values: 1494.6 1509.7 1540.3 1743.8 1914.6 7661.3 8400.7 8560.7 8579.6 8586.4 8348.2 8497.2 8560.1 8570.6 8588.5 2121.5 2358.7 2377.9 2396.4 2413.7 2380.4 2387.6 2393.7 2396.4 2396.7 2328.0 2380.7 2383.1 2390.9 2395.4 2072.5 2299.9 2339.4 2341.5 2350.0 2290.1 2325.1 2337.3 2339.1 2357.5 8436.2 8473.0 8475.4 8503.1 8515.0 5222.7 5278.9 5331.9 5334.2 5379.4 3267.8 3296.3 3366.3 3593.8 3670.6 1158.9 1162.7 1181.8 1208.3 1214.1 12275.1 12330.1 12339.4 12347.1 12372.6 4603.5 4677.6 4735.1 4749.9 4823.8 10397.2 10412.9 10418.6 10435.3 10436.1 4967.1 5458.7 5472.5 5475.6 5486.2 4943.9 4956.0 4996.7 5007.2 5017.9 4011.1 4015.2 4087.1 4120.3 4132.8 1318.6 1335.7 1342.7 1348.4 1356.0 983.8 1016.8 1031.5 1045.0 1045.3 5707.1 5784.5 5788.6 5828.0 5948.9 450.4 455.8 462.2 464.0 465.8 3918.6 3963.3 3985.5 3995.7 4017.8 10503.7 10806.7 10927.9 10947.6 10951.0 10115.5 10411.5 10690.3 10811.4 10812.7 8079.2 8144.2 8183.8 8244.2 8277.1 5545.2 5763.6 5765.9 5832.3 5883.6 9640.0 9661.8 9754.3 9860.4 9898.9 9539.5 9803.6 9973.4 10016.6 10018.8 7070.0 7441.3 7508.3 7820.3 7922.2 8034.6 8048.7 8068.1 8083.6 8099.7 7243.0 7409.4 7454.8 7458.3 7562.2 7249.2 7307.6 7318.1 7382.2 7397.7 6638.6 6680.1 6828.3 6914.8 6953.4 4861.1 5056.9 5089.5 5101.2 5125.9 4902.4 4938.5 4961.9 4995.0 5058.9 04:40:14 INFO - PROCESS | 18509 | 04:40:14 INFO - PROCESS | 18509 | [#4] prototype.html Cycles:180 Average:5483.82 Median:6305.21 stddev:1635.15 (25.9%) stddev-sans-first:1593.35 04:40:14 INFO - PROCESS | 18509 | Values: 331.7 332.8 333.3 350.6 351.9 6193.4 6229.3 6261.5 6274.8 6285.2 6213.6 6219.1 6237.9 6240.5 6262.8 4558.0 4645.2 4718.4 4730.9 4745.5 4730.3 4738.8 4744.3 4768.1 4768.5 4543.6 4710.7 4721.8 4728.1 4741.5 4592.3 4704.2 4732.1 4738.8 4751.5 4141.6 4153.8 4156.0 4161.3 4175.5 5933.3 5950.2 5962.9 5965.8 5971.9 5469.6 5472.2 5472.3 5477.5 5483.0 6377.5 6473.2 6480.1 6498.8 6503.7 4592.6 4597.4 4607.5 4610.2 4623.1 6759.6 6804.5 6806.8 6818.8 6819.5 4705.6 4708.3 4712.0 4712.1 4716.0 4779.7 4781.9 4783.7 4786.7 4787.5 5467.9 5474.8 5480.3 5489.9 5490.6 6417.9 6514.9 6588.1 6619.4 6628.1 1683.5 1688.3 1698.8 1700.6 1701.8 1069.8 1097.2 1117.2 1148.8 1157.9 6338.6 6344.0 6348.8 6348.9 6349.0 6730.9 6747.5 6750.3 6752.2 6763.8 6325.2 6330.6 6336.1 6341.2 6344.9 3606.7 3636.7 3645.7 3653.0 3656.5 6845.6 6991.5 7011.2 7020.7 7023.9 6834.5 6837.9 6843.6 6855.3 6864.0 6913.1 6930.0 6936.2 6936.4 6999.9 6706.5 6717.7 6718.4 6727.9 6729.4 6482.1 6593.8 6615.1 6622.8 6639.1 6916.6 6934.5 6941.4 6966.9 6971.4 4767.3 4768.3 4778.1 4787.8 4801.2 6702.6 6704.6 6717.0 6719.4 6724.6 6331.8 6497.7 6539.9 6548.4 6560.5 6463.1 6496.3 6496.3 6499.3 6507.4 6386.6 6402.0 6414.3 6415.5 6436.5 6538.7 6564.4 6572.2 6573.2 6581.8 6185.8 6425.7 6428.6 6434.2 6577.3 04:40:14 INFO - PROCESS | 18509 | 04:40:14 INFO - PROCESS | 18509 | [#5] yui.html Cycles:180 Average:15032.81 Median:48074.90 stddev:16889.27 (35.1%) stddev-sans-first:16903.29 04:40:14 INFO - PROCESS | 18509 | Values: 897.5 899.3 909.6 923.2 930.7 14809.8 14814.4 15148.7 15149.3 15167.8 13863.2 14173.4 14217.8 14226.0 14240.3 744.4 871.7 880.0 881.3 895.3 875.6 877.4 878.1 878.8 879.3 921.7 923.9 924.4 925.2 927.3 787.9 794.3 886.9 914.1 918.3 668.4 669.7 669.7 670.2 671.0 13706.2 13755.6 13758.9 13766.8 13804.2 13495.9 13613.5 13895.4 14323.5 14501.6 12062.9 12111.8 12210.5 12246.9 12335.0 3926.9 3989.1 4001.4 4045.1 4071.9 52445.0 52509.2 53770.7 53818.0 53854.2 11483.7 11590.8 11601.9 11629.2 11995.8 19781.6 19826.6 20031.4 20086.9 20096.7 8543.7 8671.9 8831.2 8922.9 8956.4 5070.6 5078.6 5139.9 5164.0 5309.0 3525.3 3578.0 3582.9 3583.2 3586.8 657.2 661.7 693.1 711.4 712.8 573.0 714.0 716.4 729.7 758.4 8570.0 9033.8 9249.9 9307.8 9370.0 686.3 686.5 729.2 775.3 802.4 4082.0 4160.4 4233.4 4261.6 4394.0 55265.4 55344.4 61526.7 61621.0 61973.7 52129.5 52973.0 53080.2 53955.7 54022.5 47921.3 48228.5 48690.0 48983.0 49072.0 8854.3 8928.4 8939.2 8996.4 9007.3 35775.0 36820.8 37811.2 38176.2 38786.8 48414.8 48868.5 49608.0 50525.0 50847.0 11590.9 11751.7 11794.0 11866.7 11998.5 14058.3 14316.2 14665.3 14792.1 15042.9 12952.2 13134.0 13140.2 13356.1 13833.4 13424.1 13540.1 13650.7 13754.2 14039.9 12375.1 12941.0 12980.3 13087.4 13310.4 10342.6 10532.0 10811.7 10932.3 10938.6 10835.6 10902.2 11218.0 11284.3 11302.0 04:40:14 INFO - PROCESS | 18509 | -------- Summary: end -------- 04:40:14 INFO - PROCESS | 18509 | 04:40:14 INFO - TEST-INFO | 18509: exit 0 04:40:14 INFO - TEST-OK | dromaeo_css | took 1111572ms 04:40:14 INFO - TEST-START | kraken 04:40:14 INFO - operating with platform_type : linux_ 04:40:14 INFO - Initialising browser for kraken test... 04:40:14 INFO - TEST-INFO | started process 18701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnxmRyY/profile http://localhost:47177/getInfo.html) 04:40:19 INFO - PROCESS | 18701 | __metrics Screen width/height:1600/1200 04:40:19 INFO - PROCESS | 18701 | colorDepth:24 04:40:19 INFO - PROCESS | 18701 | Browser inner width/height: 1024/697 04:40:19 INFO - PROCESS | 18701 | __metrics 04:40:20 ERROR - PROCESS | 18701 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:40:21 INFO - TEST-INFO | 18701: exit 0 04:40:21 INFO - Browser initialized. 04:40:21 INFO - Running cycle 1/1 for kraken test... 04:40:21 INFO - TEST-INFO | started process 18794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnxmRyY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:32 INFO - PROCESS | 18794 | RSS: Main: 142450688 04:40:32 INFO - PROCESS | 18794 | 04:40:35 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47177/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:36 INFO - PROCESS | 18794 | RSS: Main: 196849664 04:40:36 INFO - PROCESS | 18794 | 04:40:38 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47177/tests/kraken/driver.html?testName=audio-dft) 04:40:39 INFO - PROCESS | 18794 | RSS: Main: 182296576 04:40:39 INFO - PROCESS | 18794 | 04:40:42 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47177/tests/kraken/driver.html?testName=audio-fft) 04:40:42 INFO - PROCESS | 18794 | RSS: Main: 273018880 04:40:42 INFO - PROCESS | 18794 | 04:40:44 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47177/tests/kraken/driver.html?testName=audio-oscillator) 04:40:45 INFO - PROCESS | 18794 | RSS: Main: 178909184 04:40:45 INFO - PROCESS | 18794 | 04:40:47 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47177/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:40:48 INFO - PROCESS | 18794 | RSS: Main: 177254400 04:40:48 INFO - PROCESS | 18794 | 04:40:51 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47177/tests/kraken/driver.html?testName=imaging-darkroom) 04:40:51 INFO - PROCESS | 18794 | RSS: Main: 212393984 04:40:51 INFO - PROCESS | 18794 | 04:40:55 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47177/tests/kraken/driver.html?testName=imaging-desaturate) 04:40:55 INFO - PROCESS | 18794 | RSS: Main: 213364736 04:40:55 INFO - PROCESS | 18794 | 04:40:58 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47177/tests/kraken/driver.html?testName=json-parse-financial) 04:40:59 INFO - PROCESS | 18794 | RSS: Main: 213225472 04:40:59 INFO - PROCESS | 18794 | 04:41:00 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47177/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:41:01 INFO - PROCESS | 18794 | RSS: Main: 191922176 04:41:01 INFO - PROCESS | 18794 | 04:41:02 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47177/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:41:03 INFO - PROCESS | 18794 | RSS: Main: 196751360 04:41:03 INFO - PROCESS | 18794 | 04:41:05 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47177/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:06 INFO - PROCESS | 18794 | RSS: Main: 212205568 04:41:06 INFO - PROCESS | 18794 | 04:41:08 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47177/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:41:09 INFO - PROCESS | 18794 | RSS: Main: 213696512 04:41:09 INFO - PROCESS | 18794 | 04:41:11 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47177/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:12 INFO - PROCESS | 18794 | RSS: Main: 211427328 04:41:12 INFO - PROCESS | 18794 | 04:41:13 INFO - PROCESS | 18794 | Cycle 1(1): loaded http://localhost:47177/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47177/tests/kraken/driver.html?testName=ai-astar) 04:41:14 INFO - PROCESS | 18794 | RSS: Main: 274808832 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | __start_tp_report 04:41:14 INFO - PROCESS | 18794 | _x_x_mozilla_page_load 04:41:14 INFO - PROCESS | 18794 | _x_x_mozilla_page_load_details 04:41:14 INFO - PROCESS | 18794 | |i|pagename|runs| 04:41:14 INFO - PROCESS | 18794 | |0;ai-astar;113;112;110;110;110;112;104;111;109;109 04:41:14 INFO - PROCESS | 18794 | |1;audio-beat-detection;157;126;156;174;133;156;158;132;179;127 04:41:14 INFO - PROCESS | 18794 | |2;audio-dft;163;160;160;163;163;162;160;161;160;159 04:41:14 INFO - PROCESS | 18794 | |3;audio-fft;78;75;75;172;76;75;76;74;158;76 04:41:14 INFO - PROCESS | 18794 | |4;audio-oscillator;91;91;156;92;91;92;159;91;93;152 04:41:14 INFO - PROCESS | 18794 | |5;imaging-gaussian-blur;116;117;117;117;117;117;118;117;117;117 04:41:14 INFO - PROCESS | 18794 | |6;imaging-darkroom;146;145;145;146;147;145;146;145;146;145 04:41:14 INFO - PROCESS | 18794 | |7;imaging-desaturate;94;94;95;95;95;94;95;94;95;95 04:41:14 INFO - PROCESS | 18794 | |8;json-parse-financial;54;54;53;54;54;55;54;78;53;52 04:41:14 INFO - PROCESS | 18794 | |9;json-stringify-tinderbox;58;59;57;57;58;58;60;58;58;60 04:41:14 INFO - PROCESS | 18794 | |10;stanford-crypto-aes;73;73;72;72;74;73;74;74;73;72 04:41:14 INFO - PROCESS | 18794 | |11;stanford-crypto-ccm;114;112;114;110;113;110;112;114;133;125 04:41:14 INFO - PROCESS | 18794 | |12;stanford-crypto-pbkdf2;155;156;155;157;156;157;165;159;157;159 04:41:14 INFO - PROCESS | 18794 | |13;stanford-crypto-sha256-iterative;65;65;65;65;64;64;66;67;66;62 04:41:14 INFO - PROCESS | 18794 | __end_tp_report 04:41:14 INFO - PROCESS | 18794 | __start_cc_report 04:41:14 INFO - PROCESS | 18794 | _x_x_mozilla_cycle_collect,1618 04:41:14 INFO - PROCESS | 18794 | __end_cc_report 04:41:14 INFO - PROCESS | 18794 | __startTimestamp1462534874231__endTimestamp 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | ------- Summary: start ------- 04:41:14 INFO - PROCESS | 18794 | Number of tests: 14 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:2.49 (2.3%) stddev-sans-first:2.40 04:41:14 INFO - PROCESS | 18794 | Values: 113.0 112.0 110.0 110.0 110.0 112.0 104.0 111.0 109.0 109.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:156.50 stddev:19.21 (12.3%) stddev-sans-first:20.19 04:41:14 INFO - PROCESS | 18794 | Values: 157.0 126.0 156.0 174.0 133.0 156.0 158.0 132.0 179.0 127.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.52 (0.9%) stddev-sans-first:1.45 04:41:14 INFO - PROCESS | 18794 | Values: 163.0 160.0 160.0 163.0 163.0 162.0 160.0 161.0 160.0 159.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.50 stddev:37.84 (50.1%) stddev-sans-first:39.72 04:41:14 INFO - PROCESS | 18794 | Values: 78.0 75.0 75.0 172.0 76.0 75.0 76.0 74.0 158.0 76.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:91.00 stddev:31.01 (34.1%) stddev-sans-first:32.05 04:41:14 INFO - PROCESS | 18794 | Values: 91.0 91.0 156.0 92.0 91.0 92.0 159.0 91.0 93.0 152.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 04:41:14 INFO - PROCESS | 18794 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:41:14 INFO - PROCESS | 18794 | Values: 146.0 145.0 145.0 146.0 147.0 145.0 146.0 145.0 146.0 145.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:41:14 INFO - PROCESS | 18794 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:54.00 stddev:7.74 (14.3%) stddev-sans-first:8.17 04:41:14 INFO - PROCESS | 18794 | Values: 54.0 54.0 53.0 54.0 54.0 55.0 54.0 78.0 53.0 52.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:1.06 (1.8%) stddev-sans-first:1.12 04:41:14 INFO - PROCESS | 18794 | Values: 58.0 59.0 57.0 57.0 58.0 58.0 60.0 58.0 58.0 60.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 04:41:14 INFO - PROCESS | 18794 | Values: 73.0 73.0 72.0 72.0 74.0 73.0 74.0 74.0 73.0 72.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:114.00 stddev:7.41 (6.5%) stddev-sans-first:7.83 04:41:14 INFO - PROCESS | 18794 | Values: 114.0 112.0 114.0 110.0 113.0 110.0 112.0 114.0 133.0 125.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:157.00 stddev:2.95 (1.9%) stddev-sans-first:2.98 04:41:14 INFO - PROCESS | 18794 | Values: 155.0 156.0 155.0 157.0 156.0 157.0 165.0 159.0 157.0 159.0 04:41:14 INFO - PROCESS | 18794 | 04:41:14 INFO - PROCESS | 18794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.37 (2.1%) stddev-sans-first:1.45 04:41:14 INFO - PROCESS | 18794 | Values: 65.0 65.0 65.0 65.0 64.0 64.0 66.0 67.0 66.0 62.0 04:41:14 INFO - PROCESS | 18794 | -------- Summary: end -------- 04:41:14 INFO - PROCESS | 18794 | 04:41:15 INFO - TEST-INFO | 18794: exit 0 04:41:15 INFO - TEST-OK | kraken | took 60247ms 04:41:15 INFO - SUITE-END | took 1171s 04:41:15 INFO - Completed test suite (00:19:31) 04:41:15 INFO - javascript benchmark 04:41:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3249.756268279879, 3337.716294115002, 3346.7657263991523, 3363.377775111603, 3383.3064221834525, 5500.147477141039, 5501.697406642633, 5546.417626149257, 5549.2231087647715, 5576.776928922848, 5556.499915007648, 5577.330720313558, 5588.636738611997, 5600.52395546379, 5622.269105016352, 4952.380952380952, 5045.722485263327, 5056.089903817302, 5124.692518448886, 5197.974010129944, 5057.620678449131, 5111.974440127794, 5118.6416950813455, 5119.308893299412, 5122.871928201806, 5000.97499512502, 5052.444231134572, 5065.848024559269, 5077.64456488046, 5102.872428189306, 5134.409542902558, 5155.432902380735, 5166.095933211673, 5172.974135129338, 5204.453532379083, 4908.7300198489065, 4974.726390048546, 5061.089003979319, 5081.187010078406, 5089.974550127263, 5450.618456708032, 5453.727313634342, 5487.42382049883, 5497.587680923947, 5505.779768809243, 5930.822075337746, 5930.822075337746, 5932.3474417814, 5932.902413053599, 5933.703314834284, 5924.644521328734, 5953.8809223815715, 5983.252093488314, 5988.700564971778, 6022.759089636453, 5585.622434269942, 5610.298712660918, 5632.352279487829, 5632.464915832989, 5634.098544232903, 5935.584509084322, 6131.399973055325, 6139.293981192131, 6144.569880108439, 6145.877082458326, 5743.310802703619, 5818.5345172386105, 5818.679972601548, 5820.447057529528, 5837.445442682938, 5941.138534912414, 5948.910766338508, 5953.136795164677, 5958.314793798769, 5967.433093856077, 5755.740991655385, 5787.450192231731, 5935.821925342247, 5946.524278057745, 5954.136650185786, 5868.501177399969, 5871.060630299217, 5879.323877754027, 5884.058550631964, 5911.733971971272, 4476.350929115325, 4477.574630410106, 4482.8206871725415, 4493.7977790999485, 4507.932381014288, 3962.2075584883137, 4017.5178978522763, 4031.7984100794843, 4063.674906007512, 4098.754074755524, 5663.858403539944, 5679.659220446786, 5680.11958146488, 5682.289713785777, 5683.857903552362, 5968.522518198533, 5971.701414929236, 5991.0, 5992.041273396236, 5992.790252341234, 5412.729363531807, 5604.215409842625, 5645.717714114277, 5729.427057294321, 5747.08046712524, 5090.541851233333, 5117.41149767774, 5117.8464646060675, 5123.205903085028, 5129.897402051938, 6134.938650613526, 6186.443220110212, 6189.96905015481, 6191.349908259568, 6192.566520343623, 5850.531957443309, 5880.8235752927485, 5962.522998160223, 5982.641041537521, 6000.309964354155, 6134.693265336805, 6135.723892424762, 6138.969305153446, 6142.262928448615, 6153.569250152446, 5750.338711048115, 5829.5336373090895, 5835.67903765297, 5838.591298609056, 5840.532757379485, 5908.3500814911185, 5930.0, 5946.464818166386, 5958.880822383441, 5964.910526342195, 5801.622894511843, 5816.214811000461, 5832.270966129234, 5836.620619659709, 5841.299044114733, 5650.208970744017, 5705.087186050212, 5721.656700597978, 5767.192593037062, 5772.855678608068, 5669.603127781016, 5671.17767923657, 5682.9431705684065, 5688.63023903445, 5721.1990321354215, 5793.768249269982, 5803.709814509342, 5804.738786754522, 5805.506531944832, 5816.94183058164, 5582.246396736388, 5690.3456102548735, 5750.223719797774, 5761.251037365116, 5829.417058294137], "value": 5482.036966176556, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.5198720991232, 660.389140045458, 666.5434177588351, 677.9050932869399, 755.6863901480885, 40314.39528407073, 41054.38418423722, 41132.383014254774, 41152.58847411525, 41173.0, 44922.32616510755, 45651.0, 45756.54243457573, 45773.54226457734, 45802.77098614502, 8214.589270536479, 8793.824123517526, 8982.146696063863, 10328.173746100294, 10487.423191724452, 10380.169586433105, 10522.0, 10529.2103092268, 10534.315269507457, 10537.36775793451, 10480.109190718798, 10560.577576896952, 10562.735931601734, 10565.049145576897, 10569.10162636177, 8401.53791541465, 10313.89686103137, 10493.842592361121, 10496.265261431703, 10500.529925810393, 10474.162067034618, 10579.68260952165, 10581.470926453647, 10581.84127238092, 10584.841227381596, 41527.7923610383, 42155.36766948467, 42294.78852605717, 42327.57672423298, 42329.1534169318, 3727.925441491182, 3802.258559580883, 3802.8098595070414, 3806.1816709407613, 3869.090763670535, 35370.29259414797, 35617.643823561695, 35812.64187358119, 35862.0, 36029.81985090084, 4445.355423463579, 4524.47968483622, 4536.56902594253, 4593.609543188833, 4595.103954728829, 330163.0, 331221.0, 335014.0, 335168.3241583801, 335308.0, 40797.0, 41664.0, 68572.657136714, 69084.6545767268, 69103.23587056462, 39561.0, 39659.80170099131, 39749.80125099356, 39776.40335394971, 39817.40273895894, 15117.395304187708, 17320.220590073477, 17495.387661432043, 17497.0, 17517.824821751874, 12514.249145051326, 12649.620511384674, 14785.778213326808, 15248.542543723706, 15271.236438178046, 9505.952470237604, 9513.238940884712, 9542.33203675736, 9617.663381781604, 9625.229981601455, 3664.871729489455, 3669.522962014921, 3694.907627309285, 3737.0844143185095, 3772.660460558563, 1110.8333749937574, 1121.9623888739663, 1131.332513816852, 1204.933728644933, 1234.8086046662781, 34008.31983360319, 34088.834120763655, 34736.0, 34849.65150348515, 34981.65018349784, 1187.8693343732182, 1262.5391732017931, 1285.4344088600985, 1295.9676008099684, 1332.1341128266704, 17508.299668013136, 17799.644007119787, 17848.46454606364, 17855.196516156804, 18360.173792179383, 488427.0, 494441.0, 496017.0, 496836.0, 496857.0, 63681.68159159175, 64883.67558162179, 64892.0, 64957.0, 64970.675146623966, 1407.0572716280117, 1464.8681618654373, 1485.4281101775678, 1508.2835653064706, 1595.226315237109, 30629.0, 31639.367212655157, 32271.51592726158, 32357.676423235465, 32718.34563308673, 45811.31283030824, 45936.54063459457, 45951.0, 46050.30924536202, 46234.768826155654, 288248.0, 289488.0, 289668.0, 289920.0, 290512.0, 28673.713262867106, 31431.685683142874, 31778.364432711678, 31959.201019974687, 32119.51820722738, 47334.28998565093, 49881.75059124681, 50287.74856125696, 51121.0, 51700.741496293784, 41336.793316033225, 41696.0, 41854.0, 41955.37066943937, 42846.571534285504, 39978.497620802395, 41626.37560436656, 41636.58363416327, 43541.78229108834, 43904.78047609742, 40127.79936100301, 40390.0, 40735.59264407318, 40853.59146408617, 41264.587354127274, 34458.31083378368, 35307.646923531465, 35582.28835423225, 35856.10359741027, 36157.81921090378, 27859.44281114407, 27937.720622793513, 27952.0, 28213.294667632654, 28420.85789571039], "value": 19809.357323040997, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.1698320342517, 418.41213095600693, 419.71039982412117, 428.56714718134685, 429.5446826364054, 18524.166412511437, 18992.43022709319, 19017.144228509733, 19863.702044469308, 20282.188712451483, 19421.417357479262, 20130.0, 20139.194432222732, 20174.293899713513, 20459.386218413434, 5886.558508111887, 5997.580169388145, 6027.819165425044, 6030.9396906030815, 6064.696765161746, 5870.88258234835, 5987.820365389045, 5998.9700051499685, 6003.249593800775, 6012.278526576817, 5774.249347584808, 5915.467607915287, 5974.283086029683, 5977.043673012319, 6002.759889604433, 5884.705764711747, 5904.409559044104, 5906.527477801766, 5907.291125064999, 5911.970440147815, 5290.709011004393, 5306.548943339821, 5334.466553344673, 5382.784688612451, 5386.757595908193, 23078.884605577034, 23191.0, 23534.764652353428, 23586.528269434515, 23632.645510317358, 2483.75162483752, 2552.923412297634, 2615.137004788415, 2674.4517373938297, 2992.2070651277427, 8086.838263234761, 11485.94257028718, 15131.848681513155, 15184.316705748268, 15477.613059673486, 2052.7126202331688, 2069.224040984631, 2079.12676675795, 2082.2607974169105, 2155.504234026183, 79656.20343796603, 81064.59467702742, 81133.59433202796, 83224.0, 84181.15818841856, 10751.83872241917, 10800.297980631234, 10951.4524273786, 11151.553937842558, 11284.0, 15605.68788624221, 15741.763873541906, 15813.841861581466, 15824.367025318857, 15844.44544440962, 8722.65109395617, 8783.165599268059, 8870.64517419296, 8924.375293729507, 8948.373613847098, 8797.252233560219, 8800.911990880137, 8925.955370223108, 8946.68686595966, 8967.775805604912, 6853.862922741518, 6913.827154321081, 6919.858223393084, 7009.684564194624, 7070.858582828315, 1955.2960934063726, 1963.6661767499559, 1971.1721077147633, 2005.2680771518292, 2010.1858747207405, 1056.27645063132, 1136.017344996572, 1164.4876254448186, 1178.4461303187488, 1199.7600479904054, 18913.43259702211, 19418.126184321456, 19507.512312192026, 19526.414207573795, 19759.308424205083, 1037.3205550364523, 1065.142560239015, 1103.536514663843, 1103.7020004598714, 1167.258790667915, 10708.89291107079, 10902.345859248471, 10957.452127393757, 11038.503267352988, 11077.169212309109, 530419.0, 538445.0, 545123.0, 554040.0, 563845.0, 96614.0, 96687.03312966922, 97907.51046244723, 99486.0, 100495.49752251338, 1137.5108703257679, 1150.6260465348796, 1151.9193656443967, 1155.5320095361392, 1167.9708007299716, 17077.829221707623, 17637.470875873743, 17718.557036074202, 17808.46574602764, 17840.821591783915, 40391.0, 40652.3902141474, 40898.1820363597, 41497.0, 42262.366064508446, 56849.715751420976, 58794.7060264696, 59075.409245906994, 59106.0, 59328.110078349724, 9240.630374785202, 9254.768630784285, 9307.20888724466, 9355.298352623444, 9415.952920235355, 13208.603741887759, 13287.734245315232, 13623.18260904349, 14230.217338046506, 14258.861170824459, 12189.451474683483, 12207.450664720287, 12234.938825305817, 12367.814482782946, 12590.559330423757, 11820.881791181979, 12007.75984480323, 12291.262524248574, 12317.692057698629, 12405.0, 12154.209976351509, 12345.876541234831, 12382.81425778596, 12499.500019999097, 12825.807612886001, 9110.407823491452, 9111.544422778967, 9148.176664100263, 9207.86188207164, 9248.21390181842, 8876.733697989072, 11364.659060228207, 11985.460654270404, 12141.817872731739, 12158.331291779037], "value": 9809.610550779567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.559105064006, 1509.6905134447438, 1540.3453532248795, 1743.7733094697687, 1914.6457905287523, 7661.348785353245, 8400.747977560668, 8560.657573697044, 8579.571021448934, 8586.398952073358, 8348.16518348165, 8497.235248827605, 8560.143985601437, 8570.57147142642, 8588.484690918534, 2121.52265740208, 2358.690926535772, 2377.892994815233, 2396.424858034068, 2413.722421921475, 2380.381100913766, 2387.570237357275, 2393.74865639108, 2396.3529846941315, 2396.7123945126523, 2327.9883600582057, 2380.702412198475, 2383.1063351243283, 2390.880455977203, 2395.377201927494, 2072.533679922013, 2299.942501437469, 2339.4034521197073, 2341.4965782356876, 2350.0247397330086, 2290.129750694742, 2325.104834638659, 2337.322176568793, 2339.0643742502966, 2357.54027964547, 8436.240738333518, 8472.957635211846, 8475.449095808754, 8503.149685031509, 8514.957425212835, 5222.660527065728, 5278.894422111536, 5331.946680533222, 5334.226537152092, 5379.38137114233, 3267.803931764078, 3296.307775367176, 3366.2762506061313, 3593.7843729376323, 3670.5778835434, 1158.8551431071116, 1162.6628277799427, 1181.8345431639577, 1208.3233389301931, 1214.0712355048395, 12275.140740148194, 12330.136890417674, 12339.444724987306, 12347.073969452327, 12372.56696015644, 4603.49361570227, 4677.555632214934, 4735.052989402134, 4749.881252968635, 4823.782929768169, 10397.168226541859, 10412.895871041344, 10418.583256669799, 10435.32170408921, 10436.112930401001, 4967.105920934267, 5458.727063646802, 5472.480114389126, 5475.616706830563, 5486.231927530149, 4943.9258411123865, 4956.033573453142, 4996.675216110941, 5007.1988481843455, 5017.874553136201, 4011.097503061846, 4015.231899723313, 4087.1008378156757, 4120.320147175742, 4132.8140233689555, 1318.5780550224029, 1335.7128217433299, 1342.731453709262, 1348.3595292236305, 1355.979660305096, 983.8376667849725, 1016.8017236638932, 1031.489412740698, 1044.9947750261351, 1045.341434896026, 5707.143928410688, 5784.479396854219, 5788.565857560699, 5827.970860145672, 5948.910766338508, 450.3582395087053, 455.83362072843175, 462.1911654604442, 463.9698419602715, 465.83230037186587, 3918.626890881576, 3963.3460479020637, 3985.4818873546255, 3995.680345572347, 4017.7991100445447, 10503.737406564896, 10806.675799726021, 10927.945360273148, 10947.616833410792, 10951.0, 10115.544800483996, 10411.53148108337, 10690.305130166515, 10811.35131892089, 10812.729681758019, 8079.1516890725625, 8144.185581441809, 8183.795405114801, 8244.175582441709, 8277.130901255401, 5545.195946587803, 5763.648445423678, 5765.942340576708, 5832.300123985149, 5883.61756485827, 9640.0, 9661.806763864824, 9754.268429867647, 9860.359076659994, 9898.901010990086, 9539.523023848918, 9803.607855685692, 9973.351732137387, 10016.64941727036, 10018.799624007625, 7070.0, 7441.293077157661, 7508.324250817234, 7820.296173344426, 7922.247386498273, 8034.558099304594, 8048.718294859652, 8068.072171700095, 8083.636236369495, 8099.716509922125, 7242.96378518104, 7409.444291678038, 7454.813629659302, 7458.254174582498, 7562.2059683734615, 7249.238829922782, 7307.5980821055355, 7318.085239345082, 7382.187959324363, 7397.741079062207, 6638.601683898982, 6680.098186744727, 6828.283030281749, 6914.792556223321, 6953.374196322356, 4861.149298872612, 5056.898862022813, 5089.491050894881, 5101.183810590288, 5125.92311115341, 4902.362692849907, 4938.506149385033, 4961.875953101201, 4995.0, 5058.9494105058475], "value": 4533.928825733339, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.72798305389574, 332.836909914142, 333.2734638488095, 350.5880590306391, 351.87684310491346, 6193.38066193381, 6229.345918678536, 6261.53038522111, 6274.811755647326, 6285.214348206474, 6213.627182369061, 6219.129321894939, 6237.937620623792, 6240.469560087398, 6262.780802671908, 4557.977210113945, 4645.210314246586, 4718.4337879454515, 4730.90538189236, 4745.477997420281, 4730.266808644666, 4738.8341408050555, 4744.264638980963, 4768.070226305872, 4768.523147685239, 4543.568361005699, 4710.693804902688, 4721.763911804396, 4728.078024785168, 4741.459025816606, 4592.288195329729, 4704.1767690654, 4732.100900828831, 4738.786754596052, 4751.501092385284, 4141.6065473779945, 4153.7507749535125, 4156.04410985472, 4161.292580261333, 4175.519815221258, 5933.258342707161, 5950.196723442366, 5962.850928726816, 5965.761369545213, 5971.940280597182, 5469.562435005229, 5472.20653005312, 5472.26124473195, 5477.5070243677865, 5483.0, 6377.521685873532, 6473.190851143607, 6480.092787009822, 6498.772542960974, 6503.674816259216, 4592.609628181609, 4597.356370108188, 4607.493175750665, 4610.193216187154, 4623.052274283764, 6759.628220447873, 6804.489663275274, 6806.7957961261245, 6818.795436136924, 6819.488538359643, 4705.60002399793, 4708.270218116198, 4711.95288047122, 4712.104700106968, 4716.033213191287, 4779.689320194177, 4781.880452988634, 4783.736894470838, 4786.736729479842, 4787.54518320759, 5467.9453205468235, 5474.835754927359, 5480.287562616834, 5489.890202195934, 5490.615656904059, 6417.871642567123, 6514.934850651528, 6588.110605068255, 6619.437347825488, 6628.105205797156, 1683.5033665068834, 1688.3077938045342, 1698.7791587093598, 1700.5578549577199, 1701.7617533545313, 1069.7539565899888, 1097.2209731091016, 1117.223529646904, 1148.7989601819647, 1157.9247348922293, 6338.58799178052, 6344.048392741126, 6348.809535713936, 6348.904766428507, 6349.015902535022, 6730.9326906731285, 6747.493937954673, 6750.32496750321, 6752.189737231563, 6763.797086087426, 6325.209348831396, 6330.620162790247, 6336.081268216083, 6341.23905131378, 6344.873102537924, 3606.6573675500786, 3636.6726994570085, 3645.671889529955, 3653.0, 3656.524651795303, 6845.5550389224545, 6991.510594258455, 7011.1586609607175, 7020.719171233093, 7023.89464158038, 6834.453243740489, 6837.863242735118, 6843.555168914005, 6855.348741869514, 6864.0, 6913.1358580177475, 6930.0, 6936.2023367312395, 6936.445084393236, 6999.930000700029, 6706.497012723968, 6717.731290748316, 6718.428933540704, 6727.93272067273, 6729.427998619976, 6482.060101285381, 6593.80218593443, 6615.140031795836, 6622.768203112868, 6639.136912201383, 6916.6166766645865, 6934.479914006571, 6941.409980151744, 6966.895496567454, 6971.407430368476, 4767.332573439652, 4768.3085952537385, 4778.1399348117675, 4787.832425865078, 4801.159797035435, 6702.597844129368, 6704.564203326768, 6716.966415167893, 6719.428848547733, 6724.596524208368, 6331.810045698637, 6497.675116244263, 6539.901901471387, 6548.443382312556, 6560.475161987125, 6463.062855885776, 6496.317886621837, 6496.317886622026, 6499.28507864144, 6507.414332710079, 6386.584871983307, 6402.03969404593, 6414.294427613052, 6415.454686351526, 6436.485081193399, 6538.673066346759, 6564.442022427956, 6572.244191917991, 6573.1783527059115, 6581.835454113494, 6185.84535386619, 6425.742970281136, 6428.646424446513, 6434.163558737334, 6577.309382514767], "value": 4949.6155242719315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.5063714956774, 899.2715900120904, 909.5906841921133, 923.2291036984122, 930.7486978515805, 14809.777853332209, 14814.407423703053, 15148.697026059499, 15149.318280677368, 15167.848321516782, 13863.168209907413, 14173.43306267748, 14217.786733198984, 14226.0, 14240.287985600731, 744.3896005275649, 871.7036207689384, 880.0495464897895, 881.2597418168737, 895.2524641923969, 875.588473417496, 877.3902138014083, 878.1174919206189, 878.7846977490524, 879.2614204068581, 921.6543796076471, 923.8937522184967, 924.431474643093, 925.2413021322518, 927.2859897878664, 787.8503084413971, 794.2653045932518, 886.8758373827669, 914.063085337531, 918.2929144558719, 668.3683918696834, 669.6651674162919, 669.7354544954716, 670.1991120610872, 671.0370618162902, 13706.177629342172, 13755.587332379944, 13758.93120534401, 13766.793498097537, 13804.240766757825, 13495.932520337434, 13613.455461781517, 13895.374708138159, 14323.498677546237, 14501.56495305132, 12062.879371206263, 12111.818322725167, 12210.511579536807, 12246.938765306117, 12335.013198944063, 3926.8625598104213, 3989.1024519483176, 4001.379786133154, 4045.0696339841707, 4071.877843664695, 52445.0, 52509.2123618146, 53770.731146344406, 53818.0, 53854.19218711722, 11483.712907177387, 11590.826137607943, 11601.883981160248, 11629.24409913353, 11995.76008479843, 19781.60436791256, 19826.60346793056, 20031.39905802828, 20086.899565502077, 20096.69854952177, 8543.700970466003, 8671.913280867111, 8831.161039701217, 8922.86615700765, 8956.373053886296, 5070.61970352225, 5078.5937125029905, 5139.948600513947, 5163.974180129076, 5308.973455132699, 3525.294941011808, 3577.964220357763, 3582.8566857325936, 3583.211693427442, 3586.7847929124337, 657.1850904877917, 661.6691654172913, 693.0747452151435, 711.4486273138256, 712.7754757251449, 573.0487390931034, 714.0328395270996, 716.3982254905904, 729.6825880741894, 758.4463341760436, 8569.95715021421, 9033.77415564616, 9249.861252081224, 9307.76730581741, 9369.953150234342, 686.306830101591, 686.5125760709852, 729.2270193594807, 775.3022279948092, 802.3861745764494, 4081.9591804082174, 4160.355144952538, 4233.364995250676, 4261.594994537653, 4393.978030109829, 55265.44734552683, 55344.446555534734, 61526.69236653788, 61621.0, 61973.690131549054, 52129.47870521322, 52973.0, 53080.203796943075, 53955.730221349426, 54022.45977540253, 47921.28118078232, 48228.5177148224, 48690.0, 48983.0, 49072.0, 8854.335924805537, 8928.375013749235, 8939.150780675825, 8996.370254082152, 9007.324450666096, 35775.0, 36820.81589592035, 37811.243775123796, 38176.23647526978, 38786.80606596949, 48414.75792621014, 48868.5113148864, 49608.0, 50525.0, 50847.0, 11590.94204528972, 11751.706207344885, 11794.0, 11866.703332416413, 11998.520059197534, 14058.297085145497, 14316.212608306643, 14665.266736663338, 14792.11247325164, 15042.924785376003, 12952.158109722837, 13134.0, 13140.211587304791, 13356.131851429625, 13833.377498012815, 13424.127431716906, 13540.137296138933, 13650.658733531742, 13754.243516606683, 14039.929800350932, 12375.133740638428, 12941.0, 12980.339030498537, 13087.41106650184, 13310.401031953392, 10342.638007669695, 10532.0, 10811.675649730521, 10932.344059356465, 10938.56245750161, 10835.620753273914, 10902.236843420884, 11217.990380865434, 11284.266522676, 11302.0], "value": 6984.447620837579, "unit": "score"}], "name": "dromaeo_css", "value": 7420.737203787391, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 110.0, 110.0, 110.0, 112.0, 104.0, 111.0, 109.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 156.0, 174.0, 133.0, 156.0, 158.0, 132.0, 179.0, 127.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 163.0, 163.0, 162.0, 160.0, 161.0, 160.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 172.0, 76.0, 75.0, 76.0, 74.0, 158.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 156.0, 92.0, 91.0, 92.0, 159.0, 91.0, 93.0, 152.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 55.0, 54.0, 78.0, 53.0, 52.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 57.0, 58.0, 58.0, 60.0, 58.0, 58.0, 60.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 72.0, 74.0, 73.0, 74.0, 74.0, 73.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 114.0, 110.0, 113.0, 110.0, 112.0, 114.0, 133.0, 125.0], "value": 115.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 156.0, 155.0, 157.0, 156.0, 157.0, 165.0, 159.0, 157.0, 159.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 66.0, 67.0, 66.0, 62.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1508.0, "alertThreshold": 2.0}]} 04:41:15 INFO - Return code: 0 04:41:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:41:15 ERROR - # TBPL SUCCESS # 04:41:15 INFO - Running post-action listener: _resource_record_post_action 04:41:15 INFO - Running post-run listener: _resource_record_post_run 04:41:16 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 511406080; Read time: 20; Write time: 540656 04:41:16 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 261218304; Read time: 0; Write time: 355804 04:41:16 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 250187776; Read time: 20; Write time: 184852 04:41:16 INFO - Running post-run listener: _upload_blobber_files 04:41:16 INFO - Blob upload gear active. 04:41:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:41:16 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 04:41:16 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'] 04:41:16 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 04:41:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:41:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:41:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:18 INFO - (blobuploader) - INFO - Done attempting. 04:41:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:41:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:41:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:18 INFO - (blobuploader) - INFO - Done attempting. 04:41:18 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:18 INFO - Return code: 0 04:41:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d8bfa00fdaba70f16322a96ad3f466e3ff489038957bc335ddbf15997f5b8f80561d15bd1d8d61a3d3ab3e7252b187fe0332a89ace3830864a18673f8b0e080", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03577da2dfcedc244c09f9683ca856b29697feff0a8a442573ca2a7a941ee00ba018a7defa1a1121812d0b771faec84da514c186711ead1aa1d9335f48695aa0"} 04:41:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:18 INFO - Contents: 04:41:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d8bfa00fdaba70f16322a96ad3f466e3ff489038957bc335ddbf15997f5b8f80561d15bd1d8d61a3d3ab3e7252b187fe0332a89ace3830864a18673f8b0e080", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03577da2dfcedc244c09f9683ca856b29697feff0a8a442573ca2a7a941ee00ba018a7defa1a1121812d0b771faec84da514c186711ead1aa1d9335f48695aa0"} 04:41:18 INFO - Running post-run listener: copy_logs_to_upload_dir 04:41:18 INFO - Copying logs to upload dir... 04:41:18 INFO - mkdir: /builds/slave/test/build/upload/logs 04:41:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.793628 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-06 04:41:18.741040) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:41:18.744990) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d8bfa00fdaba70f16322a96ad3f466e3ff489038957bc335ddbf15997f5b8f80561d15bd1d8d61a3d3ab3e7252b187fe0332a89ace3830864a18673f8b0e080", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03577da2dfcedc244c09f9683ca856b29697feff0a8a442573ca2a7a941ee00ba018a7defa1a1121812d0b771faec84da514c186711ead1aa1d9335f48695aa0"} build_url:https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d8bfa00fdaba70f16322a96ad3f466e3ff489038957bc335ddbf15997f5b8f80561d15bd1d8d61a3d3ab3e7252b187fe0332a89ace3830864a18673f8b0e080", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03577da2dfcedc244c09f9683ca856b29697feff0a8a442573ca2a7a941ee00ba018a7defa1a1121812d0b771faec84da514c186711ead1aa1d9335f48695aa0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:41:18.769842) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:41:18.770200) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1462533562.901156-1509994313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:41:18.855433) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:41:18.855761) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:41:18.856086) ========= ========= Total master_lag: 0.15 =========