builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1461187873.43 results: success (0) buildid: 20160420120429 builduid: ae4579530dd54e17a53496a45dc9bbcc revision: 5649dee23169c659655bfd2f9bae78b5b1bed073 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.433472) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.435042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.435484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.464031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.464312) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 14:31:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.2M=0.001s 2016-04-20 14:31:14 (16.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078420 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.574422) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.574728) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018269 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.631684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.632003) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5649dee23169c659655bfd2f9bae78b5b1bed073 --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 5649dee23169c659655bfd2f9bae78b5b1bed073 --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=2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 14:31:14,193 truncating revision to first 12 chars 2016-04-20 14:31:14,194 Setting DEBUG logging. 2016-04-20 14:31:14,194 attempt 1/10 2016-04-20 14:31:14,194 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5649dee23169?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 14:31:14,573 unpacking tar archive at: mozilla-aurora-5649dee23169/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677718 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:14.322596) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:14.322900) ========= script_repo_revision: 5649dee23169c659655bfd2f9bae78b5b1bed073 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:14.326344) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:14.326627) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:14.337457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-20 14:31:14.337809) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:31:14 INFO - MultiFileLogger online at 20160420 14:31:14 in /builds/slave/test 14:31:14 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 14:31:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:31:14 INFO - {'append_to_log': False, 14:31:14 INFO - 'base_work_dir': '/builds/slave/test', 14:31:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:31:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:31:14 INFO - 'branch': 'Mozilla-Aurora', 14:31:14 INFO - 'buildbot_json_path': 'buildprops.json', 14:31:14 INFO - 'config_files': ('talos/linux_config.py',), 14:31:14 INFO - 'default_actions': ('clobber', 14:31:14 INFO - 'read-buildbot-config', 14:31:14 INFO - 'download-and-extract', 14:31:14 INFO - 'populate-webroot', 14:31:14 INFO - 'create-virtualenv', 14:31:14 INFO - 'install', 14:31:14 INFO - 'run-tests'), 14:31:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:31:14 INFO - 'download_minidump_stackwalk': True, 14:31:14 INFO - 'download_symbols': 'ondemand', 14:31:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:31:14 INFO - 'tooltool.py': '/tools/tooltool.py', 14:31:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:31:14 INFO - '/tools/misc-python/virtualenv.py')}, 14:31:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:31:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:31:14 INFO - 'installer_path': 'installer.exe', 14:31:14 INFO - 'log_level': 'info', 14:31:14 INFO - 'log_name': 'talos', 14:31:14 INFO - 'log_to_console': True, 14:31:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:31:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:31:14 INFO - 'opt_config_files': (), 14:31:14 INFO - 'pip_index': False, 14:31:14 INFO - 'sps_profile': False, 14:31:14 INFO - 'sps_profile_interval': 0, 14:31:14 INFO - 'suite': 'dromaeojs', 14:31:14 INFO - 'system_bits': '32', 14:31:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:31:14 INFO - 'title': 'talos-linux64-ix-012', 14:31:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:31:14 INFO - 'use_talos_json': True, 14:31:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:31:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:31:14 INFO - 'work_dir': 'build'} 14:31:14 INFO - ##### 14:31:14 INFO - ##### Running clobber step. 14:31:14 INFO - ##### 14:31:14 INFO - Running pre-action listener: _resource_record_pre_action 14:31:14 INFO - Running main action method: clobber 14:31:14 INFO - rmtree: /builds/slave/test/build 14:31:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:31:15 INFO - Running post-action listener: _resource_record_post_action 14:31:15 INFO - ##### 14:31:15 INFO - ##### Running read-buildbot-config step. 14:31:15 INFO - ##### 14:31:15 INFO - Running pre-action listener: _resource_record_pre_action 14:31:15 INFO - Running main action method: read_buildbot_config 14:31:15 INFO - Using buildbot properties: 14:31:15 INFO - { 14:31:15 INFO - "project": "", 14:31:15 INFO - "product": "firefox", 14:31:15 INFO - "script_repo_revision": "production", 14:31:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:31:15 INFO - "repository": "", 14:31:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:31:15 INFO - "buildid": "20160420120429", 14:31:15 INFO - "pgo_build": "True", 14:31:15 INFO - "basedir": "/builds/slave/test", 14:31:15 INFO - "buildnumber": 179, 14:31:15 INFO - "slavename": "talos-linux64-ix-012", 14:31:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:31:15 INFO - "platform": "ubuntu64_hw", 14:31:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:31:15 INFO - "branch": "mozilla-aurora", 14:31:15 INFO - "repo_path": "releases/mozilla-aurora", 14:31:15 INFO - "revision": "5649dee23169c659655bfd2f9bae78b5b1bed073", 14:31:15 INFO - "stage_platform": "linux64-pgo", 14:31:15 INFO - "builduid": "ae4579530dd54e17a53496a45dc9bbcc", 14:31:15 INFO - "slavebuilddir": "test" 14:31:15 INFO - } 14:31:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 14:31:15 INFO - Running post-action listener: _resource_record_post_action 14:31:15 INFO - ##### 14:31:15 INFO - ##### Running download-and-extract step. 14:31:15 INFO - ##### 14:31:15 INFO - Running pre-action listener: _resource_record_pre_action 14:31:15 INFO - Running main action method: download_and_extract 14:31:15 INFO - mkdir: /builds/slave/test/build/tests 14:31:15 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')]} 14:31:15 INFO - https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:31:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 14:31:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 14:31:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 14:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:31:18 INFO - Downloaded 1448 bytes. 14:31:18 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 14:31:18 INFO - Using the following test package requirements: 14:31:18 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 14:31:18 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:31:18 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:31:18 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:18 INFO - u'jsshell-linux-x86_64.zip'], 14:31:18 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:31:18 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 14:31:18 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:31:18 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:31:18 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:31:18 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 14:31:18 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:31:18 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:31:18 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')]} 14:31:18 INFO - https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:31:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:31:29 INFO - Downloaded 23352853 bytes. 14:31:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:31:30 INFO - Return code: 0 14:31:30 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:30 INFO - https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:31:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:31:39 INFO - Downloaded 23352853 bytes. 14:31:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:31:41 INFO - Return code: 0 14:31:41 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')]} 14:31:41 INFO - https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 14:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 14:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 14:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:31:45 INFO - Downloaded 10845168 bytes. 14:31:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:31:45 INFO - Return code: 0 14:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:45 INFO - https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:31:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 14:31:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 14:31:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 14:31:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:31:52 INFO - Downloaded 60600916 bytes. 14:31:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 14:31:52 INFO - mkdir: /builds/slave/test/properties 14:31:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:52 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:52 INFO - Contents: 14:31:52 INFO - build_url:https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 14:31:53 INFO - Running post-action listener: _resource_record_post_action 14:31:53 INFO - Running post-action listener: set_extra_try_arguments 14:31:53 INFO - ##### 14:31:53 INFO - ##### Running populate-webroot step. 14:31:53 INFO - ##### 14:31:53 INFO - Running pre-action listener: _resource_record_pre_action 14:31:53 INFO - Running main action method: populate_webroot 14:31:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:31:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:31:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:31:53 INFO - '--tppagecycles', 14:31:53 INFO - '7'], 14:31:53 INFO - 'tests': ['tsvgm']}}, 14:31:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:31:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:31:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:31:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:31:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:31:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:31:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:53 INFO - 'talos_options': ['--e10s'], 14:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:53 INFO - 'tests': ['damp', 'tps']}, 14:31:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:53 INFO - 'talos_options': ['--e10s'], 14:31:53 INFO - 'tests': ['damp', 'tps']}, 14:31:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:31:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:31:53 INFO - 'other': {'tests': ['a11yr', 14:31:53 INFO - 'ts_paint', 14:31:53 INFO - 'tpaint', 14:31:53 INFO - 'sessionrestore', 14:31:53 INFO - 'sessionrestore_no_auto_restore', 14:31:53 INFO - 'tabpaint']}, 14:31:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:31:53 INFO - 'tests': ['a11yr', 14:31:53 INFO - 'ts_paint', 14:31:53 INFO - 'tpaint', 14:31:53 INFO - 'sessionrestore', 14:31:53 INFO - 'sessionrestore_no_auto_restore', 14:31:53 INFO - 'tabpaint']}, 14:31:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:31:53 INFO - 'tests': ['a11yr', 14:31:53 INFO - 'ts_paint', 14:31:53 INFO - 'tpaint', 14:31:53 INFO - 'sessionrestore', 14:31:53 INFO - 'sessionrestore_no_auto_restore', 14:31:53 INFO - 'tabpaint']}, 14:31:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:31:53 INFO - 'tests': ['a11yr', 14:31:53 INFO - 'ts_paint', 14:31:53 INFO - 'tpaint', 14:31:53 INFO - 'sessionrestore', 14:31:53 INFO - 'sessionrestore_no_auto_restore', 14:31:53 INFO - 'tabpaint']}, 14:31:53 INFO - 'other_l64': {'tests': ['a11yr', 14:31:53 INFO - 'ts_paint', 14:31:53 INFO - 'tpaint', 14:31:53 INFO - 'sessionrestore', 14:31:53 INFO - 'sessionrestore_no_auto_restore', 14:31:53 INFO - 'tabpaint']}, 14:31:53 INFO - 'other_nol64': {'tests': ['a11yr', 14:31:53 INFO - 'ts_paint', 14:31:53 INFO - 'tpaint', 14:31:53 INFO - 'sessionrestore', 14:31:53 INFO - 'sessionrestore_no_auto_restore', 14:31:53 INFO - 'tabpaint']}, 14:31:53 INFO - 'svgr': {'tests': ['tsvgx', 14:31:53 INFO - 'tsvgr_opacity', 14:31:53 INFO - 'tart', 14:31:53 INFO - 'tscrollx', 14:31:53 INFO - 'cart']}, 14:31:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:31:53 INFO - 'tests': ['tsvgx', 14:31:53 INFO - 'tsvgr_opacity', 14:31:53 INFO - 'tart', 14:31:53 INFO - 'tscrollx', 14:31:53 INFO - 'cart']}, 14:31:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:53 INFO - 'tests': ['tp5o']}, 14:31:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:53 INFO - 'talos_options': ['--e10s'], 14:31:53 INFO - 'tests': ['tp5o']}, 14:31:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:53 INFO - 'talos_options': ['--xperf_path', 14:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:53 INFO - 'tests': ['tp5n']}, 14:31:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:53 INFO - 'talos_options': ['--e10s', 14:31:53 INFO - '--xperf_path', 14:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:53 INFO - 'tests': ['tp5n']}}, 14:31:53 INFO - 'talos.zip': {'path': '', 14:31:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:31:53 INFO - Running post-action listener: _resource_record_post_action 14:31:53 INFO - ##### 14:31:53 INFO - ##### Running create-virtualenv step. 14:31:53 INFO - ##### 14:31:53 INFO - Running pre-action listener: _resource_record_pre_action 14:31:53 INFO - Running main action method: create_virtualenv 14:31:53 INFO - Creating virtualenv /builds/slave/test/build/venv 14:31:53 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 14:31:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:31:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:31:53 INFO - Using real prefix '/usr' 14:31:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:31:54 INFO - Installing distribute.............................................................................................................................................................................................done. 14:31:55 INFO - Installing pip.................done. 14:31:55 INFO - Return code: 0 14:31:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:55 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 0x7f10d804cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f8160>, '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 0x18f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f94f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', '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 14:31:55 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 14:31:55 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 14:31:55 INFO - Using env: {'DISPLAY': ':0', 14:31:55 INFO - 'HOME': '/home/cltbld', 14:31:55 INFO - 'LANG': 'en_US.UTF-8', 14:31:55 INFO - 'LANGUAGE': 'en_US:en', 14:31:55 INFO - 'LOGNAME': 'cltbld', 14:31:55 INFO - 'MAIL': '/var/mail/cltbld', 14:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:55 INFO - 'MOZ_NO_REMOTE': '1', 14:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:55 INFO - 'NO_EM_RESTART': '1', 14:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:55 INFO - 'PWD': '/builds/slave/test', 14:31:55 INFO - 'SHELL': '/bin/bash', 14:31:55 INFO - 'SHLVL': '1', 14:31:55 INFO - 'TERM': 'linux', 14:31:55 INFO - 'TMOUT': '86400', 14:31:55 INFO - 'USER': 'cltbld', 14:31:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', 14:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:55 INFO - '_': '/tools/buildbot/bin/python'} 14:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:56 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 14:31:56 INFO - Cleaning up... 14:31:56 INFO - Return code: 0 14:31:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:31:56 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')]} 14:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:56 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')]} 14:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:56 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 0x7f10d804cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f8160>, '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 0x18f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f94f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', '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 14:31:56 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 14:31:56 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 14:31:56 INFO - Using env: {'DISPLAY': ':0', 14:31:56 INFO - 'HOME': '/home/cltbld', 14:31:56 INFO - 'LANG': 'en_US.UTF-8', 14:31:56 INFO - 'LANGUAGE': 'en_US:en', 14:31:56 INFO - 'LOGNAME': 'cltbld', 14:31:56 INFO - 'MAIL': '/var/mail/cltbld', 14:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:56 INFO - 'MOZ_NO_REMOTE': '1', 14:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:56 INFO - 'NO_EM_RESTART': '1', 14:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:56 INFO - 'PWD': '/builds/slave/test', 14:31:56 INFO - 'SHELL': '/bin/bash', 14:31:56 INFO - 'SHLVL': '1', 14:31:56 INFO - 'TERM': 'linux', 14:31:56 INFO - 'TMOUT': '86400', 14:31:56 INFO - 'USER': 'cltbld', 14:31:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', 14:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:56 INFO - '_': '/tools/buildbot/bin/python'} 14:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:56 INFO - Downloading/unpacking psutil>=0.7.1 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:31:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:58 INFO - Installing collected packages: psutil 14:31:58 INFO - Running setup.py install for psutil 14:31:58 INFO - building 'psutil._psutil_linux' extension 14:31:58 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 14:31:58 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 14:31:58 INFO - building 'psutil._psutil_posix' extension 14:31:58 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 14:31:58 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 14:31:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:58 INFO - Successfully installed psutil 14:31:58 INFO - Cleaning up... 14:31:58 INFO - Return code: 0 14:31:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f10d804cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f8160>, '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 0x18f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f94f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', '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 14:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:31:58 INFO - Using env: {'DISPLAY': ':0', 14:31:58 INFO - 'HOME': '/home/cltbld', 14:31:58 INFO - 'LANG': 'en_US.UTF-8', 14:31:58 INFO - 'LANGUAGE': 'en_US:en', 14:31:58 INFO - 'LOGNAME': 'cltbld', 14:31:58 INFO - 'MAIL': '/var/mail/cltbld', 14:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:58 INFO - 'MOZ_NO_REMOTE': '1', 14:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:58 INFO - 'NO_EM_RESTART': '1', 14:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:58 INFO - 'PWD': '/builds/slave/test', 14:31:58 INFO - 'SHELL': '/bin/bash', 14:31:58 INFO - 'SHLVL': '1', 14:31:58 INFO - 'TERM': 'linux', 14:31:59 INFO - 'TMOUT': '86400', 14:31:59 INFO - 'USER': 'cltbld', 14:31:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', 14:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:59 INFO - '_': '/tools/buildbot/bin/python'} 14:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:32:01 INFO - Installing collected packages: mozsystemmonitor 14:32:01 INFO - Running setup.py install for mozsystemmonitor 14:32:01 INFO - Successfully installed mozsystemmonitor 14:32:01 INFO - Cleaning up... 14:32:01 INFO - Return code: 0 14:32:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f10d804cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f8160>, '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 0x18f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f94f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', '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 14:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:32:01 INFO - Using env: {'DISPLAY': ':0', 14:32:01 INFO - 'HOME': '/home/cltbld', 14:32:01 INFO - 'LANG': 'en_US.UTF-8', 14:32:01 INFO - 'LANGUAGE': 'en_US:en', 14:32:01 INFO - 'LOGNAME': 'cltbld', 14:32:01 INFO - 'MAIL': '/var/mail/cltbld', 14:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:01 INFO - 'MOZ_NO_REMOTE': '1', 14:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:01 INFO - 'NO_EM_RESTART': '1', 14:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:01 INFO - 'PWD': '/builds/slave/test', 14:32:01 INFO - 'SHELL': '/bin/bash', 14:32:01 INFO - 'SHLVL': '1', 14:32:01 INFO - 'TERM': 'linux', 14:32:01 INFO - 'TMOUT': '86400', 14:32:01 INFO - 'USER': 'cltbld', 14:32:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', 14:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:01 INFO - '_': '/tools/buildbot/bin/python'} 14:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:01 INFO - Downloading/unpacking blobuploader==1.2.4 14:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:03 INFO - Downloading blobuploader-1.2.4.tar.gz 14:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:32:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:32:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:04 INFO - Downloading docopt-0.6.1.tar.gz 14:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:32:04 INFO - Installing collected packages: blobuploader, requests, docopt 14:32:04 INFO - Running setup.py install for blobuploader 14:32:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:32:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:32:04 INFO - Running setup.py install for requests 14:32:04 INFO - Running setup.py install for docopt 14:32:04 INFO - Successfully installed blobuploader requests docopt 14:32:04 INFO - Cleaning up... 14:32:04 INFO - Return code: 0 14:32:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:04 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 0x7f10d804cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f8160>, '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 0x18f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f94f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', '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 14:32:04 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 14:32:04 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 14:32:04 INFO - Using env: {'DISPLAY': ':0', 14:32:04 INFO - 'HOME': '/home/cltbld', 14:32:04 INFO - 'LANG': 'en_US.UTF-8', 14:32:04 INFO - 'LANGUAGE': 'en_US:en', 14:32:04 INFO - 'LOGNAME': 'cltbld', 14:32:04 INFO - 'MAIL': '/var/mail/cltbld', 14:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:04 INFO - 'MOZ_NO_REMOTE': '1', 14:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:04 INFO - 'NO_EM_RESTART': '1', 14:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:04 INFO - 'PWD': '/builds/slave/test', 14:32:04 INFO - 'SHELL': '/bin/bash', 14:32:04 INFO - 'SHLVL': '1', 14:32:04 INFO - 'TERM': 'linux', 14:32:04 INFO - 'TMOUT': '86400', 14:32:04 INFO - 'USER': 'cltbld', 14:32:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', 14:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:04 INFO - '_': '/tools/buildbot/bin/python'} 14:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:04 INFO - Running setup.py (path:/tmp/pip-wVGAlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:05 INFO - Running setup.py (path:/tmp/pip-o_7RCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:05 INFO - Running setup.py (path:/tmp/pip-LVsIF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:05 INFO - Running setup.py (path:/tmp/pip-RxTkZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:05 INFO - Running setup.py (path:/tmp/pip-cCJF0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:05 INFO - Running setup.py (path:/tmp/pip-jH6v0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:05 INFO - Running setup.py (path:/tmp/pip-dcTf2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:05 INFO - Running setup.py (path:/tmp/pip-E_acB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:05 INFO - Running setup.py (path:/tmp/pip-qOxxmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:05 INFO - Running setup.py (path:/tmp/pip-7Vc9rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:05 INFO - Running setup.py (path:/tmp/pip-vlQhuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:05 INFO - Running setup.py (path:/tmp/pip-GVrS3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:05 INFO - Running setup.py (path:/tmp/pip-nl2xMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:05 INFO - Running setup.py (path:/tmp/pip-g7UDty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:05 INFO - Running setup.py (path:/tmp/pip-nOiVo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:06 INFO - Running setup.py (path:/tmp/pip-AwnVrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:06 INFO - Running setup.py (path:/tmp/pip-BloKO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:32:06 INFO - Running setup.py install for manifestparser 14:32:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:32:06 INFO - Running setup.py install for mozcrash 14:32:06 INFO - Running setup.py install for mozdebug 14:32:06 INFO - Running setup.py install for mozdevice 14:32:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:32:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:32:06 INFO - Running setup.py install for mozfile 14:32:06 INFO - Running setup.py install for mozhttpd 14:32:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:32:06 INFO - Running setup.py install for mozinfo 14:32:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:32:06 INFO - Running setup.py install for mozInstall 14:32:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:32:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:32:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:32:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:32:06 INFO - Running setup.py install for mozleak 14:32:07 INFO - Running setup.py install for mozlog 14:32:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:32:07 INFO - Running setup.py install for moznetwork 14:32:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:32:07 INFO - Running setup.py install for mozprocess 14:32:07 INFO - Running setup.py install for mozprofile 14:32:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:32:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:32:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:32:07 INFO - Running setup.py install for mozrunner 14:32:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:32:07 INFO - Running setup.py install for mozscreenshot 14:32:07 INFO - Running setup.py install for moztest 14:32:07 INFO - Running setup.py install for mozversion 14:32:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:32:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:32:07 INFO - Cleaning up... 14:32:07 INFO - Return code: 0 14:32:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:07 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 0x7f10d804cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f8160>, '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 0x18f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f94f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', '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 14:32:07 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 14:32:07 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 14:32:07 INFO - Using env: {'DISPLAY': ':0', 14:32:07 INFO - 'HOME': '/home/cltbld', 14:32:07 INFO - 'LANG': 'en_US.UTF-8', 14:32:07 INFO - 'LANGUAGE': 'en_US:en', 14:32:07 INFO - 'LOGNAME': 'cltbld', 14:32:07 INFO - 'MAIL': '/var/mail/cltbld', 14:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:07 INFO - 'MOZ_NO_REMOTE': '1', 14:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:07 INFO - 'NO_EM_RESTART': '1', 14:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:07 INFO - 'PWD': '/builds/slave/test', 14:32:07 INFO - 'SHELL': '/bin/bash', 14:32:07 INFO - 'SHLVL': '1', 14:32:07 INFO - 'TERM': 'linux', 14:32:07 INFO - 'TMOUT': '86400', 14:32:07 INFO - 'USER': 'cltbld', 14:32:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', 14:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:07 INFO - '_': '/tools/buildbot/bin/python'} 14:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:08 INFO - Running setup.py (path:/tmp/pip-1O0KHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:08 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)) 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:08 INFO - Running setup.py (path:/tmp/pip-UDosAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:08 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)) 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:08 INFO - Running setup.py (path:/tmp/pip-5_f_BV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:08 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)) 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:08 INFO - Running setup.py (path:/tmp/pip-92tTim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:08 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)) 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:08 INFO - Running setup.py (path:/tmp/pip-0qNwc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:08 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)) 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:08 INFO - Running setup.py (path:/tmp/pip-mXNf3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:08 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)) 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:08 INFO - Running setup.py (path:/tmp/pip-8g5Tvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:08 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)) 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:08 INFO - Running setup.py (path:/tmp/pip-wZqqAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:08 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)) 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:08 INFO - Running setup.py (path:/tmp/pip-t7BV7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:08 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)) 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:08 INFO - Running setup.py (path:/tmp/pip-fAe4zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:08 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)) 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:08 INFO - Running setup.py (path:/tmp/pip-MtcScI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:08 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)) 14:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:08 INFO - Running setup.py (path:/tmp/pip-EpqYyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:09 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)) 14:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:09 INFO - Running setup.py (path:/tmp/pip-2VS9s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:09 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)) 14:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:09 INFO - Running setup.py (path:/tmp/pip-LBNkWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:09 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)) 14:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:09 INFO - Running setup.py (path:/tmp/pip-GZHhEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:09 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)) 14:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:09 INFO - Running setup.py (path:/tmp/pip-zrpBDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:09 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)) 14:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:09 INFO - Running setup.py (path:/tmp/pip-FdeJJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:09 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)) 14:32:09 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)) 14:32:09 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)) 14:32:09 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)) 14:32:09 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)) 14:32:09 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)) 14:32:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:32:09 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 14:32:09 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 14:32:09 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 14:32:09 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 14:32:09 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 14:32:09 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 14:32:11 INFO - Downloading blessings-1.6.tar.gz 14:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:32:11 INFO - Installing collected packages: blessings 14:32:11 INFO - Running setup.py install for blessings 14:32:11 INFO - Successfully installed blessings 14:32:11 INFO - Cleaning up... 14:32:11 INFO - Return code: 0 14:32:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:11 INFO - Reading from file tmpfile_stdout 14:32:11 INFO - Current package versions: 14:32:11 INFO - argparse == 1.2.1 14:32:11 INFO - blessings == 1.6 14:32:11 INFO - blobuploader == 1.2.4 14:32:11 INFO - docopt == 0.6.1 14:32:11 INFO - manifestparser == 1.1 14:32:11 INFO - mozInstall == 1.12 14:32:11 INFO - mozcrash == 0.17 14:32:11 INFO - mozdebug == 0.1 14:32:11 INFO - mozdevice == 0.48 14:32:11 INFO - mozfile == 1.2 14:32:11 INFO - mozhttpd == 0.7 14:32:11 INFO - mozinfo == 0.9 14:32:11 INFO - mozleak == 0.1 14:32:11 INFO - mozlog == 3.1 14:32:11 INFO - moznetwork == 0.27 14:32:11 INFO - mozprocess == 0.22 14:32:11 INFO - mozprofile == 0.28 14:32:11 INFO - mozrunner == 6.11 14:32:11 INFO - mozscreenshot == 0.1 14:32:11 INFO - mozsystemmonitor == 0.0 14:32:11 INFO - moztest == 0.7 14:32:11 INFO - mozversion == 1.4 14:32:11 INFO - psutil == 3.1.1 14:32:11 INFO - requests == 1.2.3 14:32:11 INFO - wsgiref == 0.1.2 14:32:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:11 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')]} 14:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:11 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')]} 14:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:11 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 0x7f10d804cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f8160>, '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 0x18f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f94f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', '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 14:32:11 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 14:32:11 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 14:32:11 INFO - Using env: {'DISPLAY': ':0', 14:32:11 INFO - 'HOME': '/home/cltbld', 14:32:11 INFO - 'LANG': 'en_US.UTF-8', 14:32:11 INFO - 'LANGUAGE': 'en_US:en', 14:32:11 INFO - 'LOGNAME': 'cltbld', 14:32:11 INFO - 'MAIL': '/var/mail/cltbld', 14:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:11 INFO - 'MOZ_NO_REMOTE': '1', 14:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:11 INFO - 'NO_EM_RESTART': '1', 14:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:11 INFO - 'PWD': '/builds/slave/test', 14:32:11 INFO - 'SHELL': '/bin/bash', 14:32:11 INFO - 'SHLVL': '1', 14:32:11 INFO - 'TERM': 'linux', 14:32:11 INFO - 'TMOUT': '86400', 14:32:11 INFO - 'USER': 'cltbld', 14:32:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', 14:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:11 INFO - '_': '/tools/buildbot/bin/python'} 14:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:11 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)) 14:32:11 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)) 14:32:11 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)) 14:32:11 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)) 14:32:11 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)) 14:32:11 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)) 14:32:11 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)) 14:32:11 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)) 14:32:11 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)) 14:32:11 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)) 14:32:11 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)) 14:32:11 INFO - Cleaning up... 14:32:11 INFO - Return code: 0 14:32:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:32:11 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')]} 14:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:11 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')]} 14:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:11 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 0x7f10d804cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f8160>, '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 0x18f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f94f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', '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 14:32:11 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 14:32:11 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 14:32:11 INFO - Using env: {'DISPLAY': ':0', 14:32:11 INFO - 'HOME': '/home/cltbld', 14:32:11 INFO - 'LANG': 'en_US.UTF-8', 14:32:11 INFO - 'LANGUAGE': 'en_US:en', 14:32:11 INFO - 'LOGNAME': 'cltbld', 14:32:11 INFO - 'MAIL': '/var/mail/cltbld', 14:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:11 INFO - 'MOZ_NO_REMOTE': '1', 14:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:11 INFO - 'NO_EM_RESTART': '1', 14:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:11 INFO - 'PWD': '/builds/slave/test', 14:32:11 INFO - 'SHELL': '/bin/bash', 14:32:11 INFO - 'SHLVL': '1', 14:32:11 INFO - 'TERM': 'linux', 14:32:11 INFO - 'TMOUT': '86400', 14:32:11 INFO - 'USER': 'cltbld', 14:32:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', 14:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:11 INFO - '_': '/tools/buildbot/bin/python'} 14:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:12 INFO - Downloading/unpacking jsonschema 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:32:14 INFO - Downloading/unpacking functools32 (from jsonschema) 14:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:14 INFO - Downloading functools32-3.2.3-2.tar.gz 14:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:32:14 INFO - warning: no files found matching '*.txt' 14:32:14 INFO - no previously-included directories found matching 'build' 14:32:14 INFO - no previously-included directories found matching 'dist' 14:32:14 INFO - no previously-included directories found matching '.git*' 14:32:14 INFO - Installing collected packages: jsonschema, functools32 14:32:14 INFO - Running setup.py install for functools32 14:32:14 INFO - warning: no files found matching '*.txt' 14:32:14 INFO - no previously-included directories found matching 'build' 14:32:14 INFO - no previously-included directories found matching 'dist' 14:32:14 INFO - no previously-included directories found matching '.git*' 14:32:14 INFO - Successfully installed jsonschema functools32 14:32:14 INFO - Cleaning up... 14:32:14 INFO - Return code: 0 14:32:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f10d804cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1869410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f8160>, '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 0x18f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f94f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', '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 14:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:32:14 INFO - Using env: {'DISPLAY': ':0', 14:32:14 INFO - 'HOME': '/home/cltbld', 14:32:14 INFO - 'LANG': 'en_US.UTF-8', 14:32:14 INFO - 'LANGUAGE': 'en_US:en', 14:32:14 INFO - 'LOGNAME': 'cltbld', 14:32:14 INFO - 'MAIL': '/var/mail/cltbld', 14:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:14 INFO - 'MOZ_NO_REMOTE': '1', 14:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:14 INFO - 'NO_EM_RESTART': '1', 14:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:14 INFO - 'PWD': '/builds/slave/test', 14:32:14 INFO - 'SHELL': '/bin/bash', 14:32:14 INFO - 'SHLVL': '1', 14:32:14 INFO - 'TERM': 'linux', 14:32:14 INFO - 'TMOUT': '86400', 14:32:14 INFO - 'USER': 'cltbld', 14:32:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', 14:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:14 INFO - '_': '/tools/buildbot/bin/python'} 14:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:14 INFO - Downloading/unpacking flake8 14:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:32:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:32:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:32:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:17 INFO - no previously-included directories found matching 'docs/_build' 14:32:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:32:17 INFO - Running setup.py install for pep8 14:32:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:17 INFO - no previously-included directories found matching 'docs/_build' 14:32:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:32:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:32:17 INFO - Cleaning up... 14:32:17 INFO - Return code: 0 14:32:17 INFO - Running post-action listener: _resource_record_post_action 14:32:17 INFO - Running post-action listener: _start_resource_monitoring 14:32:17 INFO - Starting resource monitoring. 14:32:17 INFO - ##### 14:32:17 INFO - ##### Running install step. 14:32:17 INFO - ##### 14:32:17 INFO - Running pre-action listener: _resource_record_pre_action 14:32:17 INFO - Running main action method: install 14:32:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:17 INFO - Reading from file tmpfile_stdout 14:32:17 INFO - Detecting whether we're running mozinstall >=1.0... 14:32:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:32:17 INFO - Reading from file tmpfile_stdout 14:32:17 INFO - Output received: 14:32:17 INFO - Usage: mozinstall [options] installer 14:32:17 INFO - Options: 14:32:17 INFO - -h, --help show this help message and exit 14:32:17 INFO - -d DEST, --destination=DEST 14:32:17 INFO - Directory to install application into. [default: 14:32:17 INFO - "/builds/slave/test"] 14:32:17 INFO - --app=APP Application being installed. [default: firefox] 14:32:17 INFO - mkdir: /builds/slave/test/build/application 14:32:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:32:33 INFO - Reading from file tmpfile_stdout 14:32:33 INFO - Output received: 14:32:33 INFO - /builds/slave/test/build/application/firefox/firefox 14:32:33 INFO - Running post-action listener: _resource_record_post_action 14:32:33 INFO - ##### 14:32:33 INFO - ##### Running run-tests step. 14:32:33 INFO - ##### 14:32:33 INFO - Running pre-action listener: _resource_record_pre_action 14:32:33 INFO - Running main action method: run_tests 14:32:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:32:33 INFO - Python 2.7.3 14:32:33 INFO - Return code: 0 14:32:33 INFO - grabbing minidump binary from tooltool 14:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:33 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 0x18f8160>, '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 0x18f9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f94f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:32:33 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 14:32:33 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 14:32:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:32:33 INFO - Return code: 0 14:32:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:32:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:32:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:32:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:32:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:32:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:32:34 INFO - Return code: 0 14:32:34 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/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 14:32:34 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/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 14:32:34 INFO - Using env: {'DISPLAY': ':0', 14:32:34 INFO - 'HOME': '/home/cltbld', 14:32:34 INFO - 'LANG': 'en_US.UTF-8', 14:32:34 INFO - 'LANGUAGE': 'en_US:en', 14:32:34 INFO - 'LOGNAME': 'cltbld', 14:32:34 INFO - 'MAIL': '/var/mail/cltbld', 14:32:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:32:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:34 INFO - 'MOZ_NO_REMOTE': '1', 14:32:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:34 INFO - 'NO_EM_RESTART': '1', 14:32:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:34 INFO - 'PWD': '/builds/slave/test', 14:32:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:32:34 INFO - 'SHELL': '/bin/bash', 14:32:34 INFO - 'SHLVL': '1', 14:32:34 INFO - 'TERM': 'linux', 14:32:34 INFO - 'TMOUT': '86400', 14:32:34 INFO - 'USER': 'cltbld', 14:32:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181', 14:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:34 INFO - '_': '/tools/buildbot/bin/python'} 14:32:34 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/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 14:32:34 INFO - mozversion application_buildid: 20160420120429 14:32:34 INFO - mozversion application_changeset: 5649dee23169c659655bfd2f9bae78b5b1bed073 14:32:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:32:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:32:34 INFO - mozversion application_name: Firefox 14:32:34 INFO - mozversion application_remotingname: firefox-dev 14:32:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:32:34 INFO - mozversion application_vendor: Mozilla 14:32:34 INFO - mozversion application_version: 47.0a2 14:32:34 INFO - mozversion platform_buildid: 20160420120429 14:32:34 INFO - mozversion platform_changeset: 5649dee23169c659655bfd2f9bae78b5b1bed073 14:32:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:32:34 INFO - mozversion platform_version: 47.0a2 14:32:34 INFO - using testdate: 1461187954 14:32:34 INFO - actual date: 1461187954 14:32:34 INFO - starting webserver on 'localhost:46588' 14:32:34 INFO - SUITE-START | Running 2 tests 14:32:34 INFO - TEST-START | dromaeo_css 14:32:34 INFO - operating with platform_type : linux_ 14:32:34 INFO - Initialising browser for dromaeo_css test... 14:32:34 INFO - TEST-INFO | started process 17648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1qydG7/profile http://localhost:46588/getInfo.html) 14:32:38 INFO - PROCESS | 17648 | __metrics Screen width/height:1600/1200 14:32:38 INFO - PROCESS | 17648 | colorDepth:24 14:32:38 INFO - PROCESS | 17648 | Browser inner width/height: 1024/697 14:32:38 INFO - PROCESS | 17648 | __metrics 14:32:38 INFO - PROCESS | 17648 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:32:39 INFO - TEST-INFO | 17648: exit 0 14:32:39 INFO - Browser initialized. 14:32:39 INFO - Running cycle 1/1 for dromaeo_css test... 14:32:39 INFO - TEST-INFO | started process 17735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1qydG7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:51 INFO - PROCESS | 17735 | RSS: Main: 141606912 14:32:51 INFO - PROCESS | 17735 | 14:33:42 INFO - PROCESS | 17735 | 1461188022780 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] 14:35:50 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:46588/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46588/tests/dromaeo/cssquery-ext.html) 14:35:51 INFO - PROCESS | 17735 | RSS: Main: 257269760 14:35:51 INFO - PROCESS | 17735 | 14:38:53 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:46588/tests/dromaeo/cssquery-ext.html (next: http://localhost:46588/tests/dromaeo/cssquery-jquery.html) 14:38:53 INFO - PROCESS | 17735 | RSS: Main: 224542720 14:38:53 INFO - PROCESS | 17735 | 14:41:55 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:46588/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46588/tests/dromaeo/cssquery-mootools.html) 14:41:56 INFO - PROCESS | 17735 | RSS: Main: 219463680 14:41:56 INFO - PROCESS | 17735 | 14:44:58 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:46588/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46588/tests/dromaeo/cssquery-prototype.html) 14:44:58 INFO - PROCESS | 17735 | RSS: Main: 192704512 14:44:58 INFO - PROCESS | 17735 | 14:48:01 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:46588/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46588/tests/dromaeo/cssquery-yui.html) 14:48:01 INFO - PROCESS | 17735 | RSS: Main: 206131200 14:48:01 INFO - PROCESS | 17735 | 14:51:03 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:46588/tests/dromaeo/cssquery-yui.html (next: http://localhost:46588/tests/dromaeo/cssquery-dojo.html) 14:51:04 INFO - PROCESS | 17735 | RSS: Main: 250535936 14:51:04 INFO - PROCESS | 17735 | 14:51:04 INFO - PROCESS | 17735 | __start_tp_report 14:51:04 INFO - PROCESS | 17735 | _x_x_mozilla_page_load 14:51:04 INFO - PROCESS | 17735 | _x_x_mozilla_page_load_details 14:51:04 INFO - PROCESS | 17735 | |i|pagename|runs| 14:51:04 INFO - PROCESS | 17735 | |0;dojo.html;3253.918652033699;3375.7468189885763;3388.5086662433932;3394.2532642818587;3423.5720534933134;5526.50261476467;5541.722913854312;5550.86122846928;5554.222408862763;5563.276774019372;5492.917606235909;5547.0570003099465;5550.833474995757;5557.055300598898;5558.833235002946;4875.195592727196;5065.442801291846;5090.440051594322;5181.119209734355;5187.325647665798;4975.552200301972;5060.0385926674;5062;5070.6957582545165;5075.822346217883;5038.193888977764;5042.243663450475;5090.9745451272875;5101.413337466183;5113.6931784092885;5066.822661206877;5079.644424890259;5124.256982737519;5132.538071573539;5145.614078944094;4889.315495830587;4901.901961960776;5003.224500202475;5005.799768009275;5024.698518088926;5327.493888080665;5343.251944727741;5358.785648574052;5362.115250983583;5364.195370694388;5805.767769289223;5836.766529338822;5867.911981320283;5883.352831188566;5883.852903677443;5900.527957763368;5926.140709597084;5929.288485381739;5955.731992060368;5960.821175364746;5498.395176530578;5505.532029777433;5506.724663766796;5511.035568775448;5522.889542209214;5956.910646340309;6008.909866352008;6028.849278768066;6055.333913269536;6075.787347442907;5775.393583673737;5789.218455508537;5795.884082318415;5847.26909136358;5860.794872179454;5929.584929054925;5943.0194017987415;5943.316518600416;5949.434803693643;5951.970240148771;5755.798547050833;5819.359870414251;5891.381404952418;5927.792527261525;5941.197938278277;5868.823935281948;5890.587658863838;5904.616199947076;5909.556783241274;5910.852228694231;4471.5081341052455;4511.120331535319;4519.367288579601;4521.299198624219;4547.067851090518;3975.741576797499;4018;4074.1444296698023;4089.3865920111625;4106.774127422961;5632.662040277514;5648.971755141198;5649.858753531194;5650.802221922213;5653.462921022497;5782.335031471351;5995.070764031582;5998.610090344114;6001.039833626599;6004.54965877561;5539.446055394428;5564.27664403633;5589.916151257735;5596.188552659923;5665.801696940587;5121.385433747974;5134.358205224347;5136.818531737721;5139;5143.562797162208;5883.941160588425;6012.368701286389;6118.724657390339;6132.570720049643;6132.908006379907;5917.881642367214;5918.023526118142;5921.230240068763;5924.585279030426;5956.106584012259;5948.524118070457;6070.514358851369;6072.666003369681;6075.058365953284;6081.726322315418;5711.742971566373;5816.331121921034;5851.678157701367;5857;5902.586818922806;5922.2597175353085;5929.169916211647;5931.466168044896;5931.9406805931385;5951.494122999594;5687.829365119053;5743.8564035899435;5788.739506722123;5789.2763404574425;5796.565257605612;5671.6029877909805;5732.369439361583;5785.652860828363;5818.679972601548;5847.883042339215;5687.914681279702;5689.6586204827845;5709.65742055478;5712.028955077563;5716.256886604715;5835.153902684172;5837.5329973601165;5839.5036421904615;5851.1515830205235;5853.824385268449;5494.780208791603;5536;5627.577931655061;5729.598928074995;5761.395053519488 14:51:04 INFO - PROCESS | 17735 | |1;ext.html;545.1386808842027;565.7058329668575;570.0267319583194;601.4616917858517;604.5919004671846;39882.401763973525;40619;40631.39052914205;40662.59337406625;40896.59103408965;44171.337429938576;44664.55335446644;44832.1033579329;44916.3262551062;45016;8821.073787252326;9026.638934442615;9042.773930651721;9052.140046695553;9055.728328150166;8998.730038098867;9164.037776033521;9188.632454701838;9189.402688825205;9193.862092068624;9130;9135.04082071383;9167.44995300284;9196.12636799503;9214.308926830481;9095.590698418588;9120.042395548438;9167.72496825093;9177.311701622404;9179.036201198845;8994.28045756338;9138.54307284633;9142.954285228532;9144;9144.542772861398;43906;44169.55830441687;44272.77863610694;44306.33540496895;44349.55650443486;3813.2564149990762;3949.940750888739;4230.450041494617;4270.551592082848;4466.843660471868;32787.67212327894;33116.33767324664;33143.17142071443;33324.83337583321;34101.658983410096;4362.760048197348;4377.956220437787;4396.296592545177;4419.447569053868;4527.954720452786;296000;296922.99999999785;297338;297804;298894;46111.76944115258;47054.76472617615;63930.36069639244;65216.34783652198;65266;44576.554234457886;44758.32862507065;44826.55173448224;44881;44933.55066449359;16548.255328510248;16858;16860.74708879368;16865.578360541083;16875.24061417239;12228.082893783001;12235.388230588613;12245.265284082983;12245.32650704202;12254.938725306494;14965.476208332657;15680.294386752623;15692.68614627724;15716.92141539285;15852.52442426729;5724.656520608777;5752.6836024019085;5767.307923049261;5844.211031510777;5887.35239123696;954.4082668745423;1085.5603480590373;1131.2590253384046;1146.9713257168637;1161.0363398379325;30208.244793880327;30450;31210.53184202239;31276.218094547818;31286.68713312883;1133.580575187186;1151.5451396698256;1154.2324354304462;1164.057113737875;1169.502961241469;16053.19734013318;16110.838891610934;16218.270177842025;16329.224031914602;16584.253708582903;330694;332223;334068;334938;335181;58953.70523147357;60046.099308510406;60318.39681603128;60372;60445.09332360018;1309.8231738715342;1391.24177323359;1430.4635761589195;1475.4762059468949;1484.896057276002;28117.859410702815;28685.856570717013;30057.54913676253;30181.547276790425;31161.37677246488;48218.27672584844;48285.275720863516;48670.26994595013;48725.0254994891;48796.5120348792;183784;188388;189349;202865;203605;30989;34972.300553989284;35263.64736352603;35357.116072098404;35565.82217088898;41839.16321673489;42858.78570607127;42880.35679464873;43141.568584313754;43441.34837977496;35747.46378804268;36049.459258110626;36121.63878361183;36508;37669.62330376771;37591.43612845864;38404.23191536098;38703.41944870885;38944.2211155781;39262.4110638335;38283;38430.6156938427;38582.6141738579;39061;39329;33067.17332066718;34319.656803431644;34689.82655086708;34827.65172348244;35043.64956350404;26554.468910622065;26972.46055078848;27067.323316917234;27086.864565677046;27242.50166240876 14:51:04 INFO - PROCESS | 17735 | |2;jquery.html;377.34153901441977;379.1412450798939;384.6768714280004;389.7973054011914;393.04490089083515;17745;18277.634447311048;18983.81016189838;19048.428547143572;19067.04664766763;13753.381097850595;16659;17359.566010849736;17361.218745156468;17372.739408908878;5220.112580861253;5335.733213339317;5375.946240537603;5377.247185394048;5377.73623198548;4096.0783823639595;5655.632383895054;5913.763449462016;5918.792842250522;5923.348431672513;5814.186013958049;5833.300003999505;5899.970500147493;5916.142159386886;5927.851803704921;5608.2428872102355;5719.19931209631;5738.0245358288985;5740.971295143519;5744.080947048452;3948.1116748731592;4103.4460347852955;4103.712740108193;4111.218868414991;5426.321709786277;13939.930300348535;13982.161070335813;14086.929565352108;17131;22030.669539956914;2441.5116976604572;2532.7593878581506;2620.947581048368;3105.3013072058834;3116.1430606583144;9770.853437198448;10267.743306417324;10419.531121099568;10548.525316360781;10751.83872241917;1832.3861506395374;1910.5414700471786;1933.3233368321116;1958.4614231086423;2006.4983754061484;65478;66014;66440.3355966439;66596.3340366595;67741.32258677449;10583.788324233472;10718.142548596094;10725.731856703645;10792.838107428395;10842.132629389629;15052.698946021019;15068.321925513379;15179.241037948279;15209.391624334903;15214.467493637669;7866.331361834308;8021.478603890729;8079.5960201989665;8124.106348301682;8139.79650508742;7552.584607846511;7681.3854891608535;7918.208179182036;7927.3658107351275;8322.084570697218;4652.837150699709;4664.86005419838;4746.691465054761;4752.643551733634;4766.451858036301;1766.1441104558985;1777.9644407111784;1908.4656296237076;1937.118611031977;1948.5226119600504;889.9911000889908;990.5393991793707;1014.264658122855;1056.8837427882927;1116.1126904111252;16356.345746170258;16796.58008549796;16870.072146032086;17604.38384656531;18100.909495452703;987.6691308411763;987.9308448408686;992.9156021738089;1020.5101551255439;1026.9897301026895;10045.045720656526;10190.643327483502;10198.592056317664;10216.489175541194;10386.42874641902;471089;473477;475919;483355;484174;80247;83528;85566;86076.56961715152;86089;1066.898644628759;1082.5345101606226;1088.7495875948418;1089.0797276301512;1105.2539535813294;15960;16010;16060.839391605934;16155.27301271422;16395.9180204103;32981;33795.32409351848;33872.15319617029;34589;34866.82566587151;44127.77936110299;48819.75590122027;48900;48905.755471222416;48958.5104148954;8458.450200736932;8654.437461564978;8806.251468624981;8860.911390886009;8879.600417981077;10082.143017843566;10531.157507399543;12841.93579032099;13080.869191308346;13527.188368697909;11277.548898043986;11382.317060976367;11468.827967580326;11584.826227606762;11689.766204676029;10964.945175274073;11024.062954648623;11054.668359949215;11298.887011129784;11539.36533490666;11107.833382499108;11267.718307042389;11654.53381864716;11875.406229688653;11952.521899123938;8572.871406928776;8671.523066231417;8783.472991620523;8970.058143895058;8987.685431009882;11325.32048077118;11624.88375116238;11651.242669226473;11684;11811.173217874666 14:51:04 INFO - PROCESS | 17735 | |3;mootools.html;1461.1817382265924;1530.6862093270881;1546.5743378416807;1714.2457318779736;1837.7886543047553;8001.119876813553;8263.462874913126;8304.501729896196;8321.08468068512;8321.375896807742;8117;8280.792980175484;8293.709720159795;8299.502029878211;8302;2058.9794102058936;2109.166879082761;2420.2376251480814;2452.7792498675117;2478.615814548739;2492.1651246832334;2509.849409035464;2511.4349271413967;2514.1577571513567;2515.3963048868322;2430.732619411863;2493.252024392675;2518.4711210645787;2519.8488090714523;2522.205505265835;2432.85402875828;2459.9754002460013;2495.987520062406;2497.1509686706427;2507.949841003188;2421.87890605469;2431.379998100491;2438.366024833538;2440.646106314592;2445.9388515287083;8410.915890841074;8444.0289366723;8450.154984501562;8461.95769021151;8479.830403391898;5256.553192978601;5425.945740542584;5426.240326354314;5426.403095659474;5429.104197807357;3090.860911258999;3146.181992681896;3152.511360739089;3306.2395649000864;3309.9503507447407;1050.1703654113242;1091.9672409827717;1092.9945350273276;1097.0510508410248;1111.472050775883;11949;11984.280943143352;12004.099692523008;12024.218425802383;12033.278003319741;4736.313234580966;4772.475027746945;4783.7129772213775;4806.466594859526;4870.14772414826;9926.354786938826;9932.950335248277;9933.850992235122;9942.552585133686;9955.104040636377;5207.531322181022;5208.479152084761;5211.60912931524;5214.348206474191;5215.374155101412;4230.365445183185;4542.159700455426;4576.771161441981;4643.3731446255;4645.512221216791;3944.447777311179;3955.149642826806;3960.5643379228263;3986.60133986599;4053.9391909121387;1343.825302710661;1346.6431395680152;1357.9728405431836;1363.2025265219759;1370.6710389506447;971.5676523946776;1197.060307658484;1240.4789988204975;1502.0987407555378;1518.6886688228888;8021.639026243833;8120.715774947848;8127;8145.755627331189;8151.8777218341775;547.2448021730066;553.6871667507926;553.7895599672099;555.2337773872031;559;6325.841853953596;6329.335419780857;6377.553571249968;6388.488920886318;6390.84022899422;9816.36193647425;10391.064804167661;10546.367217966794;10554.788904222027;10611.84082238767;10099.596016159272;10227.130693891102;10387.532561034772;10394;10435.217358698128;8056.436049476481;8091.757247282591;8183.345332373396;8213.301869341054;8213.425060245845;7798.6490607923915;7808.102068262223;7847.646855891385;7866.9213307866185;7977.760667179994;9188.724338269863;9232.815343692953;9245.58394872219;9277.582508787256;9546;9460.385074970105;9565.61737530491;9619.422834629944;9627.085426884434;9766.414015159113;6724.562903411263;7245.637718113968;7434.628268586657;7442.627868606656;7521.247875212435;8107.986501687289;8109.986251718535;8128.715494957648;8158.388120890838;8176.3867709920805;7280.089988751406;7502.737404190827;7557.35762460197;7602.239776022575;7658.961705191438;7169.749058782918;7530.4352173588295;7542.132654744555;7615.6953721850505;7625.161232264558;7484.962575187307;7494.5503269803985;7522.736704215326;7529.736459223901;7546.66040028189;6881.724731010904;7026.262242464672;7094.361507464353;7099.290070993066;7222.169450513258;7122.180949190702;7148.142222933281;7191.928080719126;7193.568385896863;7203.819904502429 14:51:04 INFO - PROCESS | 17735 | |4;prototype.html;345.19741600778195;364.5279363224624;368.1863082587482;372.945922841188;380.0555619286072;6058.242719660037;6058.242719660043;6059.636421814695;6068.544859135561;6081.695915204239;5988.64068155911;5991.730372133254;5999.520038396929;6005.159277701126;6014.548908831834;4532.184206842767;4608.953910460903;4656.045510670313;4677.836275730333;4725.952740472603;4686.156491831469;4708.19960606696;4709.317149013391;4716.504766999467;4725.362076119732;4700.929486057712;4707.693999890013;4715.339852420664;4717.551832575899;4721.976390118045;4486.708363956349;4595.908081838378;4689.9765501172615;4692.389989301403;4703.377334819482;4143.544210136883;4153.709240353146;4165.75005499671;4172.061286210578;4189.476315460567;5754.827355179351;5763.740631671585;5766.365699773021;5772.48047675707;5782.913256301159;5457.890842183174;5461.262729531502;5463.754131064112;5464.754086066137;5466.180072989044;6368.808935731936;6371.522135839784;6377;6379.425851673325;6381.074744162117;4387.341898715218;4476.7090139140855;4499.505054444008;4508.233600287959;4619.653525985565;6579.93420065798;6620.602763834186;6633.568818026813;6651.33486651331;6666.366695163952;4621.6764826462495;4625.699329543569;4628;4636.142313671981;4644.349791029259;4695.131400690883;4697.459792123881;4708.976455117702;4711.599514041276;4716.103940251342;5381.48875856793;5386.811461598825;5388.515033646991;5389.110796718497;5390.19147127934;6274.9686251569365;6392.360763923571;6425.58233714807;6428.389303016206;6429.6463694496315;1651.6696660667915;1660.5184496496122;1669.4991502549187;1669.8914570552874;1672.3310675729563;1033.7674023344837;1097.3306283167262;1100.1254003067581;1104.679642903565;1120.1598800899326;6146.293176284695;6155.230596175388;6162.476189523851;6171.6297022178815;6176.598521096114;6558.868822623616;6569.474442044625;6571.342865713486;6576.80269591913;6576.86846263072;6026.819195424145;6150.138980542728;6150.415710507495;6152.661603611844;6153.29237137726;3527.276908233806;3561.269939662363;3567.500549923013;3567.6075631680496;3574.8748793792092;6559.8520258954495;6762.087118238975;6778.76274330406;6783.219929708048;6787.5588086774205;6685.665716714242;6691.431228345645;6715.294894036154;6728.629925354153;6736.797896063126;6744.595324280559;6746.359095885883;6750.628715420601;6756.4932630052945;6760.661966901635;6545.70544325516;6551.148350714377;6551.868962620816;6552.246491653521;6563.310852360624;6315.052742088724;6448.161738973903;6460.967695161682;6464.773732919325;6466.547341686037;6721.495887808532;6726.596404215763;6746.460283177432;6746.9325306746305;6756.763513277012;4658.953410465852;4665.813367465399;4667.696599721007;4671.509491503343;4673.6494762892235;6528;6540.934590654033;6602.63685497283;6609.1408116944485;6610.2398224204835;6218.315985241529;6374.681265936591;6380.138681277968;6381.425671689571;6386.265579458236;6344.555881088279;6361.300256971822;6361.840953976188;6362.363763623785;6374.107624932421;6212.627242365473;6298.244210694746;6328.810135695937;6329.7468101275435;6331.145295385064;6339.461145802474;6371.87256254863;6375.776847810304;6381.617102973836;6386.201724784402;6087.908681369871;6199.318075011835;6210.720517576629;6229.221347331583;6358.491320694426 14:51:04 INFO - PROCESS | 17735 | |5;yui.html;807.5195258821;837.891074160359;839.8824164616951;923.3351986569668;940.9435433873967;13127.1467354622;13305;13318.467261309548;13328.333583320831;13328.866711332883;12771.106022578424;12794.360281985886;12824.102312838106;12870.935645321784;12874.549390771324;760.5968836516628;899.442345745637;905.6920646980026;916.3722849847876;919.2094798473307;919.6735159018552;932.9720108396759;933.0482907434447;933.4772527384653;933.519237592637;951.3863558005118;967.3277072434661;969.2827307792254;969.321474967522;969.5733877094091;827.5779352530222;945.7446489447844;958.4488918871642;967.4630580028152;988.1057642833248;720.2329519062182;722.7614887087249;722.9060222171137;724.0984973707715;724.9528780629242;13240.073194876362;13318.933405333008;13354.532591359255;13365.264910429922;13365.599032029055;13024.153430027018;13503.12229705066;13599.388027538685;13602.931985340108;13678.384472698752;10675.252732308742;10785.137189024937;10820.837687434694;10850.782984340349;11144;3805.2009078093356;3816.0650640592953;3875.767453952744;3882.4758657581147;3946.072672921861;52672;52977.2053419199;53055.734721326146;53059.73470132625;53233.73383133098;9521.523923803783;10127.696169114939;10179.898201018043;10295.639652612272;10362.963703629577;18521.166547505396;18555.90722046408;18558.72161917572;19559.11983960725;19681;8091.635876385577;8167.550784706779;8204.179582041748;8221.136780637948;8324;4424.3142312941545;4430.800613972379;4436.0906014267;4555.840545580889;4620;3309.635940046593;3348.0625424881073;3350.3969285528838;3356.14418323326;3356.714679252291;558.9017580454426;629.5215636116584;646.6475770704977;654.4698793976894;659.0805825872976;520.7838746920062;575.9712014399263;593.4510577715596;595.3926994465621;612.1063247658379;8333.916660833314;8369.707060252862;8396.412251142483;8401.15988401155;8556.657733690707;581.3227589857853;597.9431953964366;602.9267903132431;607.8328459673537;612.859042420237;3955.228730397545;3963.147923196527;3986.760794352348;4035.7174997750462;4071.918561628751;58560.41439585635;58972;59689.701551492835;60744.39255607387;61080.38919610836;51959.22061169086;52885.7355713219;52895.94208115816;53329.2000619991;53392.199117013275;47117;48784;48805.26792098121;49168.26247606289;49963;8732.78168045804;8746.65013399457;8827.382083254111;9103.908960910307;9354.95322523383;37096;37771.43342849804;38235.23529529338;38585;39002.6099738999;46381.76809115933;47247;47683.284750728075;47818.5218147828;48660.75669621629;11055.557777689124;11169.944150279196;11198.720031999264;11270.718232043937;11497.367644779282;11948.103892207946;11960.34218117977;12059.51761929513;12360.62918112422;12569.49722011146;11645.847358316301;11700.941495292469;11747.823782643096;11799.233049851731;11833.526658933546;11100;11192.21654484211;11286.379249141377;11319.377434241196;11438.199326047097;11429.828552571884;11471.885281147082;11607.535698571963;11670.124740644316;11677.824832627348;9430.811383772423;9620.230381569598;9663.226941844776;9730.221582273543;10197.745056373353;9849.556769945513;9899.703008909744;9938.900610994087;9951.900480995388;9957.352772069793 14:51:04 INFO - PROCESS | 17735 | __end_tp_report 14:51:04 INFO - PROCESS | 17735 | __start_cc_report 14:51:04 INFO - PROCESS | 17735 | _x_x_mozilla_cycle_collect,913 14:51:04 INFO - PROCESS | 17735 | __end_cc_report 14:51:04 INFO - PROCESS | 17735 | __startTimestamp1461189064117__endTimestamp 14:51:04 INFO - PROCESS | 17735 | 14:51:04 INFO - PROCESS | 17735 | ------- Summary: start ------- 14:51:04 INFO - PROCESS | 17735 | Number of tests: 6 14:51:04 INFO - PROCESS | 17735 | 14:51:04 INFO - PROCESS | 17735 | [#0] dojo.html Cycles:165 Average:5494.94 Median:5709.66 stddev:596.58 (10.4%) stddev-sans-first:571.92 14:51:04 INFO - PROCESS | 17735 | Values: 3253.9 3375.7 3388.5 3394.3 3423.6 5526.5 5541.7 5550.9 5554.2 5563.3 5492.9 5547.1 5550.8 5557.1 5558.8 4875.2 5065.4 5090.4 5181.1 5187.3 4975.6 5060.0 5062.0 5070.7 5075.8 5038.2 5042.2 5091.0 5101.4 5113.7 5066.8 5079.6 5124.3 5132.5 5145.6 4889.3 4901.9 5003.2 5005.8 5024.7 5327.5 5343.3 5358.8 5362.1 5364.2 5805.8 5836.8 5867.9 5883.4 5883.9 5900.5 5926.1 5929.3 5955.7 5960.8 5498.4 5505.5 5506.7 5511.0 5522.9 5956.9 6008.9 6028.8 6055.3 6075.8 5775.4 5789.2 5795.9 5847.3 5860.8 5929.6 5943.0 5943.3 5949.4 5952.0 5755.8 5819.4 5891.4 5927.8 5941.2 5868.8 5890.6 5904.6 5909.6 5910.9 4471.5 4511.1 4519.4 4521.3 4547.1 3975.7 4018.0 4074.1 4089.4 4106.8 5632.7 5649.0 5649.9 5650.8 5653.5 5782.3 5995.1 5998.6 6001.0 6004.5 5539.4 5564.3 5589.9 5596.2 5665.8 5121.4 5134.4 5136.8 5139.0 5143.6 5883.9 6012.4 6118.7 6132.6 6132.9 5917.9 5918.0 5921.2 5924.6 5956.1 5948.5 6070.5 6072.7 6075.1 6081.7 5711.7 5816.3 5851.7 5857.0 5902.6 5922.3 5929.2 5931.5 5931.9 5951.5 5687.8 5743.9 5788.7 5789.3 5796.6 5671.6 5732.4 5785.7 5818.7 5847.9 5687.9 5689.7 5709.7 5712.0 5716.3 5835.2 5837.5 5839.5 5851.2 5853.8 5494.8 5536.0 5627.6 5729.6 5761.4 14:51:04 INFO - PROCESS | 17735 | 14:51:04 INFO - PROCESS | 17735 | [#1] ext.html Cycles:180 Average:45444.66 Median:38823.82 stddev:73497.72 (189.3%) stddev-sans-first:73626.58 14:51:04 INFO - PROCESS | 17735 | Values: 545.1 565.7 570.0 601.5 604.6 39882.4 40619.0 40631.4 40662.6 40896.6 44171.3 44664.6 44832.1 44916.3 45016.0 8821.1 9026.6 9042.8 9052.1 9055.7 8998.7 9164.0 9188.6 9189.4 9193.9 9130.0 9135.0 9167.4 9196.1 9214.3 9095.6 9120.0 9167.7 9177.3 9179.0 8994.3 9138.5 9143.0 9144.0 9144.5 43906.0 44169.6 44272.8 44306.3 44349.6 3813.3 3949.9 4230.5 4270.6 4466.8 32787.7 33116.3 33143.2 33324.8 34101.7 4362.8 4378.0 4396.3 4419.4 4528.0 296000.0 296923.0 297338.0 297804.0 298894.0 46111.8 47054.8 63930.4 65216.3 65266.0 44576.6 44758.3 44826.6 44881.0 44933.6 16548.3 16858.0 16860.7 16865.6 16875.2 12228.1 12235.4 12245.3 12245.3 12254.9 14965.5 15680.3 15692.7 15716.9 15852.5 5724.7 5752.7 5767.3 5844.2 5887.4 954.4 1085.6 1131.3 1147.0 1161.0 30208.2 30450.0 31210.5 31276.2 31286.7 1133.6 1151.5 1154.2 1164.1 1169.5 16053.2 16110.8 16218.3 16329.2 16584.3 330694.0 332223.0 334068.0 334938.0 335181.0 58953.7 60046.1 60318.4 60372.0 60445.1 1309.8 1391.2 1430.5 1475.5 1484.9 28117.9 28685.9 30057.5 30181.5 31161.4 48218.3 48285.3 48670.3 48725.0 48796.5 183784.0 188388.0 189349.0 202865.0 203605.0 30989.0 34972.3 35263.6 35357.1 35565.8 41839.2 42858.8 42880.4 43141.6 43441.3 35747.5 36049.5 36121.6 36508.0 37669.6 37591.4 38404.2 38703.4 38944.2 39262.4 38283.0 38430.6 38582.6 39061.0 39329.0 33067.2 34319.7 34689.8 34827.7 35043.6 26554.5 26972.5 27067.3 27086.9 27242.5 14:51:04 INFO - PROCESS | 17735 | 14:51:04 INFO - PROCESS | 17735 | [#2] jquery.html Cycles:180 Average:27061.82 Median:2576.85 stddev:78373.84 (3041.5%) stddev-sans-first:78568.09 14:51:04 INFO - PROCESS | 17735 | Values: 377.3 379.1 384.7 389.8 393.0 17745.0 18277.6 18983.8 19048.4 19067.0 13753.4 16659.0 17359.6 17361.2 17372.7 5220.1 5335.7 5375.9 5377.2 5377.7 4096.1 5655.6 5913.8 5918.8 5923.3 5814.2 5833.3 5900.0 5916.1 5927.9 5608.2 5719.2 5738.0 5741.0 5744.1 3948.1 4103.4 4103.7 4111.2 5426.3 13939.9 13982.2 14086.9 17131.0 22030.7 2441.5 2532.8 2620.9 3105.3 3116.1 9770.9 10267.7 10419.5 10548.5 10751.8 1832.4 1910.5 1933.3 1958.5 2006.5 65478.0 66014.0 66440.3 66596.3 67741.3 10583.8 10718.1 10725.7 10792.8 10842.1 15052.7 15068.3 15179.2 15209.4 15214.5 7866.3 8021.5 8079.6 8124.1 8139.8 7552.6 7681.4 7918.2 7927.4 8322.1 4652.8 4664.9 4746.7 4752.6 4766.5 1766.1 1778.0 1908.5 1937.1 1948.5 890.0 990.5 1014.3 1056.9 1116.1 16356.3 16796.6 16870.1 17604.4 18100.9 987.7 987.9 992.9 1020.5 1027.0 10045.0 10190.6 10198.6 10216.5 10386.4 471089.0 473477.0 475919.0 483355.0 484174.0 80247.0 83528.0 85566.0 86076.6 86089.0 1066.9 1082.5 1088.7 1089.1 1105.3 15960.0 16010.0 16060.8 16155.3 16395.9 32981.0 33795.3 33872.2 34589.0 34866.8 44127.8 48819.8 48900.0 48905.8 48958.5 8458.5 8654.4 8806.3 8860.9 8879.6 10082.1 10531.2 12841.9 13080.9 13527.2 11277.5 11382.3 11468.8 11584.8 11689.8 10964.9 11024.1 11054.7 11298.9 11539.4 11107.8 11267.7 11654.5 11875.4 11952.5 8572.9 8671.5 8783.5 8970.1 8987.7 11325.3 11624.9 11651.2 11684.0 11811.2 14:51:04 INFO - PROCESS | 17735 | 14:51:04 INFO - PROCESS | 17735 | [#3] mootools.html Cycles:180 Average:5955.19 Median:554.51 stddev:3146.43 (567.4%) stddev-sans-first:3137.12 14:51:04 INFO - PROCESS | 17735 | Values: 1461.2 1530.7 1546.6 1714.2 1837.8 8001.1 8263.5 8304.5 8321.1 8321.4 8117.0 8280.8 8293.7 8299.5 8302.0 2059.0 2109.2 2420.2 2452.8 2478.6 2492.2 2509.8 2511.4 2514.2 2515.4 2430.7 2493.3 2518.5 2519.8 2522.2 2432.9 2460.0 2496.0 2497.2 2507.9 2421.9 2431.4 2438.4 2440.6 2445.9 8410.9 8444.0 8450.2 8462.0 8479.8 5256.6 5425.9 5426.2 5426.4 5429.1 3090.9 3146.2 3152.5 3306.2 3310.0 1050.2 1092.0 1093.0 1097.1 1111.5 11949.0 11984.3 12004.1 12024.2 12033.3 4736.3 4772.5 4783.7 4806.5 4870.1 9926.4 9933.0 9933.9 9942.6 9955.1 5207.5 5208.5 5211.6 5214.3 5215.4 4230.4 4542.2 4576.8 4643.4 4645.5 3944.4 3955.1 3960.6 3986.6 4053.9 1343.8 1346.6 1358.0 1363.2 1370.7 971.6 1197.1 1240.5 1502.1 1518.7 8021.6 8120.7 8127.0 8145.8 8151.9 547.2 553.7 553.8 555.2 559.0 6325.8 6329.3 6377.6 6388.5 6390.8 9816.4 10391.1 10546.4 10554.8 10611.8 10099.6 10227.1 10387.5 10394.0 10435.2 8056.4 8091.8 8183.3 8213.3 8213.4 7798.6 7808.1 7847.6 7866.9 7977.8 9188.7 9232.8 9245.6 9277.6 9546.0 9460.4 9565.6 9619.4 9627.1 9766.4 6724.6 7245.6 7434.6 7442.6 7521.2 8108.0 8110.0 8128.7 8158.4 8176.4 7280.1 7502.7 7557.4 7602.2 7659.0 7169.7 7530.4 7542.1 7615.7 7625.2 7485.0 7494.6 7522.7 7529.7 7546.7 6881.7 7026.3 7094.4 7099.3 7222.2 7122.2 7148.1 7191.9 7193.6 7203.8 14:51:04 INFO - PROCESS | 17735 | 14:51:04 INFO - PROCESS | 17735 | [#4] prototype.html Cycles:180 Average:5363.36 Median:6084.80 stddev:1579.59 (26.0%) stddev-sans-first:1538.46 14:51:04 INFO - PROCESS | 17735 | Values: 345.2 364.5 368.2 372.9 380.1 6058.2 6058.2 6059.6 6068.5 6081.7 5988.6 5991.7 5999.5 6005.2 6014.5 4532.2 4609.0 4656.0 4677.8 4726.0 4686.2 4708.2 4709.3 4716.5 4725.4 4700.9 4707.7 4715.3 4717.6 4722.0 4486.7 4595.9 4690.0 4692.4 4703.4 4143.5 4153.7 4165.8 4172.1 4189.5 5754.8 5763.7 5766.4 5772.5 5782.9 5457.9 5461.3 5463.8 5464.8 5466.2 6368.8 6371.5 6377.0 6379.4 6381.1 4387.3 4476.7 4499.5 4508.2 4619.7 6579.9 6620.6 6633.6 6651.3 6666.4 4621.7 4625.7 4628.0 4636.1 4644.3 4695.1 4697.5 4709.0 4711.6 4716.1 5381.5 5386.8 5388.5 5389.1 5390.2 6275.0 6392.4 6425.6 6428.4 6429.6 1651.7 1660.5 1669.5 1669.9 1672.3 1033.8 1097.3 1100.1 1104.7 1120.2 6146.3 6155.2 6162.5 6171.6 6176.6 6558.9 6569.5 6571.3 6576.8 6576.9 6026.8 6150.1 6150.4 6152.7 6153.3 3527.3 3561.3 3567.5 3567.6 3574.9 6559.9 6762.1 6778.8 6783.2 6787.6 6685.7 6691.4 6715.3 6728.6 6736.8 6744.6 6746.4 6750.6 6756.5 6760.7 6545.7 6551.1 6551.9 6552.2 6563.3 6315.1 6448.2 6461.0 6464.8 6466.5 6721.5 6726.6 6746.5 6746.9 6756.8 4659.0 4665.8 4667.7 4671.5 4673.6 6528.0 6540.9 6602.6 6609.1 6610.2 6218.3 6374.7 6380.1 6381.4 6386.3 6344.6 6361.3 6361.8 6362.4 6374.1 6212.6 6298.2 6328.8 6329.7 6331.1 6339.5 6371.9 6375.8 6381.6 6386.2 6087.9 6199.3 6210.7 6229.2 6358.5 14:51:04 INFO - PROCESS | 17735 | 14:51:04 INFO - PROCESS | 17735 | [#5] yui.html Cycles:180 Average:14418.07 Median:48722.38 stddev:16905.47 (34.7%) stddev-sans-first:16922.00 14:51:04 INFO - PROCESS | 17735 | Values: 807.5 837.9 839.9 923.3 940.9 13127.1 13305.0 13318.5 13328.3 13328.9 12771.1 12794.4 12824.1 12870.9 12874.5 760.6 899.4 905.7 916.4 919.2 919.7 933.0 933.0 933.5 933.5 951.4 967.3 969.3 969.3 969.6 827.6 945.7 958.4 967.5 988.1 720.2 722.8 722.9 724.1 725.0 13240.1 13318.9 13354.5 13365.3 13365.6 13024.2 13503.1 13599.4 13602.9 13678.4 10675.3 10785.1 10820.8 10850.8 11144.0 3805.2 3816.1 3875.8 3882.5 3946.1 52672.0 52977.2 53055.7 53059.7 53233.7 9521.5 10127.7 10179.9 10295.6 10363.0 18521.2 18555.9 18558.7 19559.1 19681.0 8091.6 8167.6 8204.2 8221.1 8324.0 4424.3 4430.8 4436.1 4555.8 4620.0 3309.6 3348.1 3350.4 3356.1 3356.7 558.9 629.5 646.6 654.5 659.1 520.8 576.0 593.5 595.4 612.1 8333.9 8369.7 8396.4 8401.2 8556.7 581.3 597.9 602.9 607.8 612.9 3955.2 3963.1 3986.8 4035.7 4071.9 58560.4 58972.0 59689.7 60744.4 61080.4 51959.2 52885.7 52895.9 53329.2 53392.2 47117.0 48784.0 48805.3 49168.3 49963.0 8732.8 8746.7 8827.4 9103.9 9355.0 37096.0 37771.4 38235.2 38585.0 39002.6 46381.8 47247.0 47683.3 47818.5 48660.8 11055.6 11169.9 11198.7 11270.7 11497.4 11948.1 11960.3 12059.5 12360.6 12569.5 11645.8 11700.9 11747.8 11799.2 11833.5 11100.0 11192.2 11286.4 11319.4 11438.2 11429.8 11471.9 11607.5 11670.1 11677.8 9430.8 9620.2 9663.2 9730.2 10197.7 9849.6 9899.7 9938.9 9951.9 9957.4 14:51:04 INFO - PROCESS | 17735 | -------- Summary: end -------- 14:51:04 INFO - PROCESS | 17735 | 14:51:04 INFO - TEST-INFO | 17735: exit 0 14:51:04 INFO - TEST-OK | dromaeo_css | took 1110386ms 14:51:04 INFO - TEST-START | kraken 14:51:04 INFO - operating with platform_type : linux_ 14:51:04 INFO - Initialising browser for kraken test... 14:51:04 INFO - TEST-INFO | started process 17929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZOOvz/profile http://localhost:46588/getInfo.html) 14:51:08 INFO - PROCESS | 17929 | __metrics Screen width/height:1600/1200 14:51:08 INFO - PROCESS | 17929 | colorDepth:24 14:51:08 INFO - PROCESS | 17929 | Browser inner width/height: 1024/697 14:51:08 INFO - PROCESS | 17929 | __metrics 14:51:09 INFO - PROCESS | 17929 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:51:09 INFO - TEST-INFO | 17929: exit 0 14:51:09 INFO - Browser initialized. 14:51:09 INFO - Running cycle 1/1 for kraken test... 14:51:09 INFO - TEST-INFO | started process 18023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZOOvz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:21 INFO - PROCESS | 18023 | RSS: Main: 141684736 14:51:21 INFO - PROCESS | 18023 | 14:51:24 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46588/tests/kraken/driver.html?testName=audio-beat-detection) 14:51:24 INFO - PROCESS | 18023 | RSS: Main: 178028544 14:51:24 INFO - PROCESS | 18023 | 14:51:27 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46588/tests/kraken/driver.html?testName=audio-dft) 14:51:28 INFO - PROCESS | 18023 | RSS: Main: 175968256 14:51:28 INFO - PROCESS | 18023 | 14:51:30 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46588/tests/kraken/driver.html?testName=audio-fft) 14:51:31 INFO - PROCESS | 18023 | RSS: Main: 173137920 14:51:31 INFO - PROCESS | 18023 | 14:51:33 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46588/tests/kraken/driver.html?testName=audio-oscillator) 14:51:34 INFO - PROCESS | 18023 | RSS: Main: 173539328 14:51:34 INFO - PROCESS | 18023 | 14:51:36 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46588/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:51:36 INFO - PROCESS | 18023 | RSS: Main: 171323392 14:51:36 INFO - PROCESS | 18023 | 14:51:39 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46588/tests/kraken/driver.html?testName=imaging-darkroom) 14:51:40 INFO - PROCESS | 18023 | RSS: Main: 171671552 14:51:40 INFO - PROCESS | 18023 | 14:51:43 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46588/tests/kraken/driver.html?testName=imaging-desaturate) 14:51:44 INFO - PROCESS | 18023 | RSS: Main: 172519424 14:51:44 INFO - PROCESS | 18023 | 14:51:47 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46588/tests/kraken/driver.html?testName=json-parse-financial) 14:51:47 INFO - PROCESS | 18023 | RSS: Main: 172011520 14:51:47 INFO - PROCESS | 18023 | 14:51:49 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46588/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:51:49 INFO - PROCESS | 18023 | RSS: Main: 175861760 14:51:49 INFO - PROCESS | 18023 | 14:51:51 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46588/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:51:52 INFO - PROCESS | 18023 | RSS: Main: 174592000 14:51:52 INFO - PROCESS | 18023 | 14:51:54 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46588/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:51:54 INFO - PROCESS | 18023 | RSS: Main: 180269056 14:51:54 INFO - PROCESS | 18023 | 14:51:57 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:51:57 INFO - PROCESS | 18023 | RSS: Main: 187375616 14:51:57 INFO - PROCESS | 18023 | 14:52:00 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:52:00 INFO - PROCESS | 18023 | RSS: Main: 185540608 14:52:00 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | Cycle 1(1): loaded http://localhost:46588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46588/tests/kraken/driver.html?testName=ai-astar) 14:52:02 INFO - PROCESS | 18023 | RSS: Main: 246980608 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | __start_tp_report 14:52:02 INFO - PROCESS | 18023 | _x_x_mozilla_page_load 14:52:02 INFO - PROCESS | 18023 | _x_x_mozilla_page_load_details 14:52:02 INFO - PROCESS | 18023 | |i|pagename|runs| 14:52:02 INFO - PROCESS | 18023 | |0;ai-astar;110;110;105;109;109;109;100;110;110;110 14:52:02 INFO - PROCESS | 18023 | |1;audio-beat-detection;159;126;156;168;132;159;160;129;186;126 14:52:02 INFO - PROCESS | 18023 | |2;audio-dft;163;163;161;160;162;163;160;164;160;162 14:52:02 INFO - PROCESS | 18023 | |3;audio-fft;76;75;76;165;78;75;74;75;165;76 14:52:02 INFO - PROCESS | 18023 | |4;audio-oscillator;94;94;158;92;93;94;143;92;92;150 14:52:02 INFO - PROCESS | 18023 | |5;imaging-gaussian-blur;117;117;116;116;116;116;116;116;117;116 14:52:02 INFO - PROCESS | 18023 | |6;imaging-darkroom;146;146;146;145;151;146;146;145;146;147 14:52:02 INFO - PROCESS | 18023 | |7;imaging-desaturate;95;96;95;96;95;96;95;95;96;95 14:52:02 INFO - PROCESS | 18023 | |8;json-parse-financial;56;56;56;56;57;56;55;64;54;53 14:52:02 INFO - PROCESS | 18023 | |9;json-stringify-tinderbox;63;64;65;64;65;65;65;65;65;64 14:52:02 INFO - PROCESS | 18023 | |10;stanford-crypto-aes;78;78;78;78;77;76;77;78;84;77 14:52:02 INFO - PROCESS | 18023 | |11;stanford-crypto-ccm;119;122;117;114;111;113;116;115;111;111 14:52:02 INFO - PROCESS | 18023 | |12;stanford-crypto-pbkdf2;139;128;141;139;141;128;139;137;137;138 14:52:02 INFO - PROCESS | 18023 | |13;stanford-crypto-sha256-iterative;70;65;66;65;67;67;66;66;64;65 14:52:02 INFO - PROCESS | 18023 | __end_tp_report 14:52:02 INFO - PROCESS | 18023 | __start_cc_report 14:52:02 INFO - PROCESS | 18023 | _x_x_mozilla_cycle_collect,1040 14:52:02 INFO - PROCESS | 18023 | __end_cc_report 14:52:02 INFO - PROCESS | 18023 | __startTimestamp1461189122592__endTimestamp 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | ------- Summary: start ------- 14:52:02 INFO - PROCESS | 18023 | Number of tests: 14 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.26 (3.0%) stddev-sans-first:3.39 14:52:02 INFO - PROCESS | 18023 | Values: 110.0 110.0 105.0 109.0 109.0 109.0 100.0 110.0 110.0 110.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:159.00 stddev:20.64 (13.0%) stddev-sans-first:21.64 14:52:02 INFO - PROCESS | 18023 | Values: 159.0 126.0 156.0 168.0 132.0 159.0 160.0 129.0 186.0 126.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.48 (0.9%) stddev-sans-first:1.50 14:52:02 INFO - PROCESS | 18023 | Values: 163.0 163.0 161.0 160.0 162.0 163.0 160.0 164.0 160.0 162.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.50 stddev:37.70 (49.9%) stddev-sans-first:39.45 14:52:02 INFO - PROCESS | 18023 | Values: 76.0 75.0 76.0 165.0 78.0 75.0 74.0 75.0 165.0 76.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:92.50 stddev:27.93 (30.2%) stddev-sans-first:29.00 14:52:02 INFO - PROCESS | 18023 | Values: 94.0 94.0 158.0 92.0 93.0 94.0 143.0 92.0 92.0 150.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 14:52:02 INFO - PROCESS | 18023 | Values: 117.0 117.0 116.0 116.0 116.0 116.0 116.0 116.0 117.0 116.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.71 (1.2%) stddev-sans-first:1.81 14:52:02 INFO - PROCESS | 18023 | Values: 146.0 146.0 146.0 145.0 151.0 146.0 146.0 145.0 146.0 147.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:52:02 INFO - PROCESS | 18023 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:2.95 (5.3%) stddev-sans-first:3.12 14:52:02 INFO - PROCESS | 18023 | Values: 56.0 56.0 56.0 56.0 57.0 56.0 55.0 64.0 54.0 53.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.71 (1.1%) stddev-sans-first:0.50 14:52:02 INFO - PROCESS | 18023 | Values: 63.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 64.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:2.18 (2.8%) stddev-sans-first:2.32 14:52:02 INFO - PROCESS | 18023 | Values: 78.0 78.0 78.0 78.0 77.0 76.0 77.0 78.0 84.0 77.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#11] stanford-crypto-ccm Cycles:10 Average:114.90 Median:115.50 stddev:3.70 (3.2%) stddev-sans-first:3.61 14:52:02 INFO - PROCESS | 18023 | Values: 119.0 122.0 117.0 114.0 111.0 113.0 116.0 115.0 111.0 111.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.70 Median:139.00 stddev:4.79 (3.4%) stddev-sans-first:5.00 14:52:02 INFO - PROCESS | 18023 | Values: 139.0 128.0 141.0 139.0 141.0 128.0 139.0 137.0 137.0 138.0 14:52:02 INFO - PROCESS | 18023 | 14:52:02 INFO - PROCESS | 18023 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.66 (2.5%) stddev-sans-first:1.00 14:52:02 INFO - PROCESS | 18023 | Values: 70.0 65.0 66.0 65.0 67.0 67.0 66.0 66.0 64.0 65.0 14:52:02 INFO - PROCESS | 18023 | -------- Summary: end -------- 14:52:02 INFO - PROCESS | 18023 | 14:52:03 INFO - TEST-INFO | 18023: exit 0 14:52:03 INFO - TEST-OK | kraken | took 58676ms 14:52:03 INFO - SUITE-END | took 1169s 14:52:03 INFO - Completed test suite (00:19:29) 14:52:03 INFO - javascript benchmark 14:52:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3253.918652033699, 3375.7468189885763, 3388.5086662433932, 3394.2532642818587, 3423.5720534933134, 5526.50261476467, 5541.722913854312, 5550.86122846928, 5554.222408862763, 5563.276774019372, 5492.917606235909, 5547.0570003099465, 5550.833474995757, 5557.055300598898, 5558.833235002946, 4875.195592727196, 5065.442801291846, 5090.440051594322, 5181.119209734355, 5187.325647665798, 4975.552200301972, 5060.0385926674, 5062.0, 5070.6957582545165, 5075.822346217883, 5038.193888977764, 5042.243663450475, 5090.9745451272875, 5101.413337466183, 5113.6931784092885, 5066.822661206877, 5079.644424890259, 5124.256982737519, 5132.538071573539, 5145.614078944094, 4889.315495830587, 4901.901961960776, 5003.224500202475, 5005.799768009275, 5024.698518088926, 5327.493888080665, 5343.251944727741, 5358.785648574052, 5362.115250983583, 5364.195370694388, 5805.767769289223, 5836.766529338822, 5867.911981320283, 5883.352831188566, 5883.852903677443, 5900.527957763368, 5926.140709597084, 5929.288485381739, 5955.731992060368, 5960.821175364746, 5498.395176530578, 5505.532029777433, 5506.724663766796, 5511.035568775448, 5522.889542209214, 5956.910646340309, 6008.909866352008, 6028.849278768066, 6055.333913269536, 6075.787347442907, 5775.393583673737, 5789.218455508537, 5795.884082318415, 5847.26909136358, 5860.794872179454, 5929.584929054925, 5943.0194017987415, 5943.316518600416, 5949.434803693643, 5951.970240148771, 5755.798547050833, 5819.359870414251, 5891.381404952418, 5927.792527261525, 5941.197938278277, 5868.823935281948, 5890.587658863838, 5904.616199947076, 5909.556783241274, 5910.852228694231, 4471.5081341052455, 4511.120331535319, 4519.367288579601, 4521.299198624219, 4547.067851090518, 3975.741576797499, 4018.0, 4074.1444296698023, 4089.3865920111625, 4106.774127422961, 5632.662040277514, 5648.971755141198, 5649.858753531194, 5650.802221922213, 5653.462921022497, 5782.335031471351, 5995.070764031582, 5998.610090344114, 6001.039833626599, 6004.54965877561, 5539.446055394428, 5564.27664403633, 5589.916151257735, 5596.188552659923, 5665.801696940587, 5121.385433747974, 5134.358205224347, 5136.818531737721, 5139.0, 5143.562797162208, 5883.941160588425, 6012.368701286389, 6118.724657390339, 6132.570720049643, 6132.908006379907, 5917.881642367214, 5918.023526118142, 5921.230240068763, 5924.585279030426, 5956.106584012259, 5948.524118070457, 6070.514358851369, 6072.666003369681, 6075.058365953284, 6081.726322315418, 5711.742971566373, 5816.331121921034, 5851.678157701367, 5857.0, 5902.586818922806, 5922.2597175353085, 5929.169916211647, 5931.466168044896, 5931.9406805931385, 5951.494122999594, 5687.829365119053, 5743.8564035899435, 5788.739506722123, 5789.2763404574425, 5796.565257605612, 5671.6029877909805, 5732.369439361583, 5785.652860828363, 5818.679972601548, 5847.883042339215, 5687.914681279702, 5689.6586204827845, 5709.65742055478, 5712.028955077563, 5716.256886604715, 5835.153902684172, 5837.5329973601165, 5839.5036421904615, 5851.1515830205235, 5853.824385268449, 5494.780208791603, 5536.0, 5627.577931655061, 5729.598928074995, 5761.395053519488], "unit": "score", "name": "dojo.html", "value": 5457.123788262216}, {"lowerIsBetter": false, "replicates": [545.1386808842027, 565.7058329668575, 570.0267319583194, 601.4616917858517, 604.5919004671846, 39882.401763973525, 40619.0, 40631.39052914205, 40662.59337406625, 40896.59103408965, 44171.337429938576, 44664.55335446644, 44832.1033579329, 44916.3262551062, 45016.0, 8821.073787252326, 9026.638934442615, 9042.773930651721, 9052.140046695553, 9055.728328150166, 8998.730038098867, 9164.037776033521, 9188.632454701838, 9189.402688825205, 9193.862092068624, 9130.0, 9135.04082071383, 9167.44995300284, 9196.12636799503, 9214.308926830481, 9095.590698418588, 9120.042395548438, 9167.72496825093, 9177.311701622404, 9179.036201198845, 8994.28045756338, 9138.54307284633, 9142.954285228532, 9144.0, 9144.542772861398, 43906.0, 44169.55830441687, 44272.77863610694, 44306.33540496895, 44349.55650443486, 3813.2564149990762, 3949.940750888739, 4230.450041494617, 4270.551592082848, 4466.843660471868, 32787.67212327894, 33116.33767324664, 33143.17142071443, 33324.83337583321, 34101.658983410096, 4362.760048197348, 4377.956220437787, 4396.296592545177, 4419.447569053868, 4527.954720452786, 296000.0, 296922.99999999785, 297338.0, 297804.0, 298894.0, 46111.76944115258, 47054.76472617615, 63930.36069639244, 65216.34783652198, 65266.0, 44576.554234457886, 44758.32862507065, 44826.55173448224, 44881.0, 44933.55066449359, 16548.255328510248, 16858.0, 16860.74708879368, 16865.578360541083, 16875.24061417239, 12228.082893783001, 12235.388230588613, 12245.265284082983, 12245.32650704202, 12254.938725306494, 14965.476208332657, 15680.294386752623, 15692.68614627724, 15716.92141539285, 15852.52442426729, 5724.656520608777, 5752.6836024019085, 5767.307923049261, 5844.211031510777, 5887.35239123696, 954.4082668745423, 1085.5603480590373, 1131.2590253384046, 1146.9713257168637, 1161.0363398379325, 30208.244793880327, 30450.0, 31210.53184202239, 31276.218094547818, 31286.68713312883, 1133.580575187186, 1151.5451396698256, 1154.2324354304462, 1164.057113737875, 1169.502961241469, 16053.19734013318, 16110.838891610934, 16218.270177842025, 16329.224031914602, 16584.253708582903, 330694.0, 332223.0, 334068.0, 334938.0, 335181.0, 58953.70523147357, 60046.099308510406, 60318.39681603128, 60372.0, 60445.09332360018, 1309.8231738715342, 1391.24177323359, 1430.4635761589195, 1475.4762059468949, 1484.896057276002, 28117.859410702815, 28685.856570717013, 30057.54913676253, 30181.547276790425, 31161.37677246488, 48218.27672584844, 48285.275720863516, 48670.26994595013, 48725.0254994891, 48796.5120348792, 183784.0, 188388.0, 189349.0, 202865.0, 203605.0, 30989.0, 34972.300553989284, 35263.64736352603, 35357.116072098404, 35565.82217088898, 41839.16321673489, 42858.78570607127, 42880.35679464873, 43141.568584313754, 43441.34837977496, 35747.46378804268, 36049.459258110626, 36121.63878361183, 36508.0, 37669.62330376771, 37591.43612845864, 38404.23191536098, 38703.41944870885, 38944.2211155781, 39262.4110638335, 38283.0, 38430.6156938427, 38582.6141738579, 39061.0, 39329.0, 33067.17332066718, 34319.656803431644, 34689.82655086708, 34827.65172348244, 35043.64956350404, 26554.468910622065, 26972.46055078848, 27067.323316917234, 27086.864565677046, 27242.50166240876], "unit": "score", "name": "ext.html", "value": 18929.956639836615}, {"lowerIsBetter": false, "replicates": [377.34153901441977, 379.1412450798939, 384.6768714280004, 389.7973054011914, 393.04490089083515, 17745.0, 18277.634447311048, 18983.81016189838, 19048.428547143572, 19067.04664766763, 13753.381097850595, 16659.0, 17359.566010849736, 17361.218745156468, 17372.739408908878, 5220.112580861253, 5335.733213339317, 5375.946240537603, 5377.247185394048, 5377.73623198548, 4096.0783823639595, 5655.632383895054, 5913.763449462016, 5918.792842250522, 5923.348431672513, 5814.186013958049, 5833.300003999505, 5899.970500147493, 5916.142159386886, 5927.851803704921, 5608.2428872102355, 5719.19931209631, 5738.0245358288985, 5740.971295143519, 5744.080947048452, 3948.1116748731592, 4103.4460347852955, 4103.712740108193, 4111.218868414991, 5426.321709786277, 13939.930300348535, 13982.161070335813, 14086.929565352108, 17131.0, 22030.669539956914, 2441.5116976604572, 2532.7593878581506, 2620.947581048368, 3105.3013072058834, 3116.1430606583144, 9770.853437198448, 10267.743306417324, 10419.531121099568, 10548.525316360781, 10751.83872241917, 1832.3861506395374, 1910.5414700471786, 1933.3233368321116, 1958.4614231086423, 2006.4983754061484, 65478.0, 66014.0, 66440.3355966439, 66596.3340366595, 67741.32258677449, 10583.788324233472, 10718.142548596094, 10725.731856703645, 10792.838107428395, 10842.132629389629, 15052.698946021019, 15068.321925513379, 15179.241037948279, 15209.391624334903, 15214.467493637669, 7866.331361834308, 8021.478603890729, 8079.5960201989665, 8124.106348301682, 8139.79650508742, 7552.584607846511, 7681.3854891608535, 7918.208179182036, 7927.3658107351275, 8322.084570697218, 4652.837150699709, 4664.86005419838, 4746.691465054761, 4752.643551733634, 4766.451858036301, 1766.1441104558985, 1777.9644407111784, 1908.4656296237076, 1937.118611031977, 1948.5226119600504, 889.9911000889908, 990.5393991793707, 1014.264658122855, 1056.8837427882927, 1116.1126904111252, 16356.345746170258, 16796.58008549796, 16870.072146032086, 17604.38384656531, 18100.909495452703, 987.6691308411763, 987.9308448408686, 992.9156021738089, 1020.5101551255439, 1026.9897301026895, 10045.045720656526, 10190.643327483502, 10198.592056317664, 10216.489175541194, 10386.42874641902, 471089.0, 473477.0, 475919.0, 483355.0, 484174.0, 80247.0, 83528.0, 85566.0, 86076.56961715152, 86089.0, 1066.898644628759, 1082.5345101606226, 1088.7495875948418, 1089.0797276301512, 1105.2539535813294, 15960.0, 16010.0, 16060.839391605934, 16155.27301271422, 16395.9180204103, 32981.0, 33795.32409351848, 33872.15319617029, 34589.0, 34866.82566587151, 44127.77936110299, 48819.75590122027, 48900.0, 48905.755471222416, 48958.5104148954, 8458.450200736932, 8654.437461564978, 8806.251468624981, 8860.911390886009, 8879.600417981077, 10082.143017843566, 10531.157507399543, 12841.93579032099, 13080.869191308346, 13527.188368697909, 11277.548898043986, 11382.317060976367, 11468.827967580326, 11584.826227606762, 11689.766204676029, 10964.945175274073, 11024.062954648623, 11054.668359949215, 11298.887011129784, 11539.36533490666, 11107.833382499108, 11267.718307042389, 11654.53381864716, 11875.406229688653, 11952.521899123938, 8572.871406928776, 8671.523066231417, 8783.472991620523, 8970.058143895058, 8987.685431009882, 11325.32048077118, 11624.88375116238, 11651.242669226473, 11684.0, 11811.173217874666], "unit": "score", "name": "jquery.html", "value": 8772.149527962662}, {"lowerIsBetter": false, "replicates": [1461.1817382265924, 1530.6862093270881, 1546.5743378416807, 1714.2457318779736, 1837.7886543047553, 8001.119876813553, 8263.462874913126, 8304.501729896196, 8321.08468068512, 8321.375896807742, 8117.0, 8280.792980175484, 8293.709720159795, 8299.502029878211, 8302.0, 2058.9794102058936, 2109.166879082761, 2420.2376251480814, 2452.7792498675117, 2478.615814548739, 2492.1651246832334, 2509.849409035464, 2511.4349271413967, 2514.1577571513567, 2515.3963048868322, 2430.732619411863, 2493.252024392675, 2518.4711210645787, 2519.8488090714523, 2522.205505265835, 2432.85402875828, 2459.9754002460013, 2495.987520062406, 2497.1509686706427, 2507.949841003188, 2421.87890605469, 2431.379998100491, 2438.366024833538, 2440.646106314592, 2445.9388515287083, 8410.915890841074, 8444.0289366723, 8450.154984501562, 8461.95769021151, 8479.830403391898, 5256.553192978601, 5425.945740542584, 5426.240326354314, 5426.403095659474, 5429.104197807357, 3090.860911258999, 3146.181992681896, 3152.511360739089, 3306.2395649000864, 3309.9503507447407, 1050.1703654113242, 1091.9672409827717, 1092.9945350273276, 1097.0510508410248, 1111.472050775883, 11949.0, 11984.280943143352, 12004.099692523008, 12024.218425802383, 12033.278003319741, 4736.313234580966, 4772.475027746945, 4783.7129772213775, 4806.466594859526, 4870.14772414826, 9926.354786938826, 9932.950335248277, 9933.850992235122, 9942.552585133686, 9955.104040636377, 5207.531322181022, 5208.479152084761, 5211.60912931524, 5214.348206474191, 5215.374155101412, 4230.365445183185, 4542.159700455426, 4576.771161441981, 4643.3731446255, 4645.512221216791, 3944.447777311179, 3955.149642826806, 3960.5643379228263, 3986.60133986599, 4053.9391909121387, 1343.825302710661, 1346.6431395680152, 1357.9728405431836, 1363.2025265219759, 1370.6710389506447, 971.5676523946776, 1197.060307658484, 1240.4789988204975, 1502.0987407555378, 1518.6886688228888, 8021.639026243833, 8120.715774947848, 8127.0, 8145.755627331189, 8151.8777218341775, 547.2448021730066, 553.6871667507926, 553.7895599672099, 555.2337773872031, 559.0, 6325.841853953596, 6329.335419780857, 6377.553571249968, 6388.488920886318, 6390.84022899422, 9816.36193647425, 10391.064804167661, 10546.367217966794, 10554.788904222027, 10611.84082238767, 10099.596016159272, 10227.130693891102, 10387.532561034772, 10394.0, 10435.217358698128, 8056.436049476481, 8091.757247282591, 8183.345332373396, 8213.301869341054, 8213.425060245845, 7798.6490607923915, 7808.102068262223, 7847.646855891385, 7866.9213307866185, 7977.760667179994, 9188.724338269863, 9232.815343692953, 9245.58394872219, 9277.582508787256, 9546.0, 9460.385074970105, 9565.61737530491, 9619.422834629944, 9627.085426884434, 9766.414015159113, 6724.562903411263, 7245.637718113968, 7434.628268586657, 7442.627868606656, 7521.247875212435, 8107.986501687289, 8109.986251718535, 8128.715494957648, 8158.388120890838, 8176.3867709920805, 7280.089988751406, 7502.737404190827, 7557.35762460197, 7602.239776022575, 7658.961705191438, 7169.749058782918, 7530.4352173588295, 7542.132654744555, 7615.6953721850505, 7625.161232264558, 7484.962575187307, 7494.5503269803985, 7522.736704215326, 7529.736459223901, 7546.66040028189, 6881.724731010904, 7026.262242464672, 7094.361507464353, 7099.290070993066, 7222.169450513258, 7122.180949190702, 7148.142222933281, 7191.928080719126, 7193.568385896863, 7203.819904502429], "unit": "score", "name": "mootools.html", "value": 4793.434107657964}, {"lowerIsBetter": false, "replicates": [345.19741600778195, 364.5279363224624, 368.1863082587482, 372.945922841188, 380.0555619286072, 6058.242719660037, 6058.242719660043, 6059.636421814695, 6068.544859135561, 6081.695915204239, 5988.64068155911, 5991.730372133254, 5999.520038396929, 6005.159277701126, 6014.548908831834, 4532.184206842767, 4608.953910460903, 4656.045510670313, 4677.836275730333, 4725.952740472603, 4686.156491831469, 4708.19960606696, 4709.317149013391, 4716.504766999467, 4725.362076119732, 4700.929486057712, 4707.693999890013, 4715.339852420664, 4717.551832575899, 4721.976390118045, 4486.708363956349, 4595.908081838378, 4689.9765501172615, 4692.389989301403, 4703.377334819482, 4143.544210136883, 4153.709240353146, 4165.75005499671, 4172.061286210578, 4189.476315460567, 5754.827355179351, 5763.740631671585, 5766.365699773021, 5772.48047675707, 5782.913256301159, 5457.890842183174, 5461.262729531502, 5463.754131064112, 5464.754086066137, 5466.180072989044, 6368.808935731936, 6371.522135839784, 6377.0, 6379.425851673325, 6381.074744162117, 4387.341898715218, 4476.7090139140855, 4499.505054444008, 4508.233600287959, 4619.653525985565, 6579.93420065798, 6620.602763834186, 6633.568818026813, 6651.33486651331, 6666.366695163952, 4621.6764826462495, 4625.699329543569, 4628.0, 4636.142313671981, 4644.349791029259, 4695.131400690883, 4697.459792123881, 4708.976455117702, 4711.599514041276, 4716.103940251342, 5381.48875856793, 5386.811461598825, 5388.515033646991, 5389.110796718497, 5390.19147127934, 6274.9686251569365, 6392.360763923571, 6425.58233714807, 6428.389303016206, 6429.6463694496315, 1651.6696660667915, 1660.5184496496122, 1669.4991502549187, 1669.8914570552874, 1672.3310675729563, 1033.7674023344837, 1097.3306283167262, 1100.1254003067581, 1104.679642903565, 1120.1598800899326, 6146.293176284695, 6155.230596175388, 6162.476189523851, 6171.6297022178815, 6176.598521096114, 6558.868822623616, 6569.474442044625, 6571.342865713486, 6576.80269591913, 6576.86846263072, 6026.819195424145, 6150.138980542728, 6150.415710507495, 6152.661603611844, 6153.29237137726, 3527.276908233806, 3561.269939662363, 3567.500549923013, 3567.6075631680496, 3574.8748793792092, 6559.8520258954495, 6762.087118238975, 6778.76274330406, 6783.219929708048, 6787.5588086774205, 6685.665716714242, 6691.431228345645, 6715.294894036154, 6728.629925354153, 6736.797896063126, 6744.595324280559, 6746.359095885883, 6750.628715420601, 6756.4932630052945, 6760.661966901635, 6545.70544325516, 6551.148350714377, 6551.868962620816, 6552.246491653521, 6563.310852360624, 6315.052742088724, 6448.161738973903, 6460.967695161682, 6464.773732919325, 6466.547341686037, 6721.495887808532, 6726.596404215763, 6746.460283177432, 6746.9325306746305, 6756.763513277012, 4658.953410465852, 4665.813367465399, 4667.696599721007, 4671.509491503343, 4673.6494762892235, 6528.0, 6540.934590654033, 6602.63685497283, 6609.1408116944485, 6610.2398224204835, 6218.315985241529, 6374.681265936591, 6380.138681277968, 6381.425671689571, 6386.265579458236, 6344.555881088279, 6361.300256971822, 6361.840953976188, 6362.363763623785, 6374.107624932421, 6212.627242365473, 6298.244210694746, 6328.810135695937, 6329.7468101275435, 6331.145295385064, 6339.461145802474, 6371.87256254863, 6375.776847810304, 6381.617102973836, 6386.201724784402, 6087.908681369871, 6199.318075011835, 6210.720517576629, 6229.221347331583, 6358.491320694426], "unit": "score", "name": "prototype.html", "value": 4857.407965695672}, {"lowerIsBetter": false, "replicates": [807.5195258821, 837.891074160359, 839.8824164616951, 923.3351986569668, 940.9435433873967, 13127.1467354622, 13305.0, 13318.467261309548, 13328.333583320831, 13328.866711332883, 12771.106022578424, 12794.360281985886, 12824.102312838106, 12870.935645321784, 12874.549390771324, 760.5968836516628, 899.442345745637, 905.6920646980026, 916.3722849847876, 919.2094798473307, 919.6735159018552, 932.9720108396759, 933.0482907434447, 933.4772527384653, 933.519237592637, 951.3863558005118, 967.3277072434661, 969.2827307792254, 969.321474967522, 969.5733877094091, 827.5779352530222, 945.7446489447844, 958.4488918871642, 967.4630580028152, 988.1057642833248, 720.2329519062182, 722.7614887087249, 722.9060222171137, 724.0984973707715, 724.9528780629242, 13240.073194876362, 13318.933405333008, 13354.532591359255, 13365.264910429922, 13365.599032029055, 13024.153430027018, 13503.12229705066, 13599.388027538685, 13602.931985340108, 13678.384472698752, 10675.252732308742, 10785.137189024937, 10820.837687434694, 10850.782984340349, 11144.0, 3805.2009078093356, 3816.0650640592953, 3875.767453952744, 3882.4758657581147, 3946.072672921861, 52672.0, 52977.2053419199, 53055.734721326146, 53059.73470132625, 53233.73383133098, 9521.523923803783, 10127.696169114939, 10179.898201018043, 10295.639652612272, 10362.963703629577, 18521.166547505396, 18555.90722046408, 18558.72161917572, 19559.11983960725, 19681.0, 8091.635876385577, 8167.550784706779, 8204.179582041748, 8221.136780637948, 8324.0, 4424.3142312941545, 4430.800613972379, 4436.0906014267, 4555.840545580889, 4620.0, 3309.635940046593, 3348.0625424881073, 3350.3969285528838, 3356.14418323326, 3356.714679252291, 558.9017580454426, 629.5215636116584, 646.6475770704977, 654.4698793976894, 659.0805825872976, 520.7838746920062, 575.9712014399263, 593.4510577715596, 595.3926994465621, 612.1063247658379, 8333.916660833314, 8369.707060252862, 8396.412251142483, 8401.15988401155, 8556.657733690707, 581.3227589857853, 597.9431953964366, 602.9267903132431, 607.8328459673537, 612.859042420237, 3955.228730397545, 3963.147923196527, 3986.760794352348, 4035.7174997750462, 4071.918561628751, 58560.41439585635, 58972.0, 59689.701551492835, 60744.39255607387, 61080.38919610836, 51959.22061169086, 52885.7355713219, 52895.94208115816, 53329.2000619991, 53392.199117013275, 47117.0, 48784.0, 48805.26792098121, 49168.26247606289, 49963.0, 8732.78168045804, 8746.65013399457, 8827.382083254111, 9103.908960910307, 9354.95322523383, 37096.0, 37771.43342849804, 38235.23529529338, 38585.0, 39002.6099738999, 46381.76809115933, 47247.0, 47683.284750728075, 47818.5218147828, 48660.75669621629, 11055.557777689124, 11169.944150279196, 11198.720031999264, 11270.718232043937, 11497.367644779282, 11948.103892207946, 11960.34218117977, 12059.51761929513, 12360.62918112422, 12569.49722011146, 11645.847358316301, 11700.941495292469, 11747.823782643096, 11799.233049851731, 11833.526658933546, 11100.0, 11192.21654484211, 11286.379249141377, 11319.377434241196, 11438.199326047097, 11429.828552571884, 11471.885281147082, 11607.535698571963, 11670.124740644316, 11677.824832627348, 9430.811383772423, 9620.230381569598, 9663.226941844776, 9730.221582273543, 10197.745056373353, 9849.556769945513, 9899.703008909744, 9938.900610994087, 9951.900480995388, 9957.352772069793], "unit": "score", "name": "yui.html", "value": 6578.0535374374385}], "name": "dromaeo_css", "value": 7195.605637749055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 109.0, 109.0, 109.0, 100.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [159.0, 126.0, 156.0, 168.0, 132.0, 159.0, 160.0, 129.0, 186.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 161.0, 160.0, 162.0, 163.0, 160.0, 164.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 76.0, 165.0, 78.0, 75.0, 74.0, 75.0, 165.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 158.0, 92.0, 93.0, 94.0, 143.0, 92.0, 92.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 151.0, 146.0, 146.0, 145.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 55.0, 64.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 78.0, 78.0, 77.0, 76.0, 77.0, 78.0, 84.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.1}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 117.0, 114.0, 111.0, 113.0, 116.0, 115.0, 111.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.9}, {"lowerIsBetter": true, "replicates": [139.0, 128.0, 141.0, 139.0, 141.0, 128.0, 139.0, 137.0, 137.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.7}, {"lowerIsBetter": true, "replicates": [70.0, 65.0, 66.0, 65.0, 67.0, 67.0, 66.0, 66.0, 64.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1498.5}]} 14:52:03 INFO - Return code: 0 14:52:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:52:03 INFO - # TBPL SUCCESS # 14:52:03 INFO - Running post-action listener: _resource_record_post_action 14:52:03 INFO - Running post-run listener: _resource_record_post_run 14:52:04 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 345223168; Read time: 8; Write time: 230456 14:52:04 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 106545152; Read time: 0; Write time: 60452 14:52:04 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 238678016; Read time: 8; Write time: 170004 14:52:04 INFO - Running post-run listener: _upload_blobber_files 14:52:04 INFO - Blob upload gear active. 14:52:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:52:04 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 14:52:04 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'] 14:52:04 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 14:52:05 INFO - (blobuploader) - INFO - Open directory for files ... 14:52:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:52:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:52:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:06 INFO - (blobuploader) - INFO - Done attempting. 14:52:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:52:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:52:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:07 INFO - (blobuploader) - INFO - Done attempting. 14:52:07 INFO - (blobuploader) - INFO - Iteration through files over. 14:52:07 INFO - Return code: 0 14:52:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:52:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:52:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f44670cc887aef28d8d27e9e92773d96f2e15178bcc2fdd5ac6835ac0e6dfc794c419d7c3322fcfa19dfcd305ec37c1a3537238f4ce8798fc56f4d58ee0f8a7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/889be222a6ec2ac99381a46549055309cc3b1a2112a1f8899b7bb477e8a297b14acc59e34e51a6f407e34ad5ae7e7810df5fe58d039312cd03ddeb65c4d52546"} 14:52:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:52:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:52:07 INFO - Contents: 14:52:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f44670cc887aef28d8d27e9e92773d96f2e15178bcc2fdd5ac6835ac0e6dfc794c419d7c3322fcfa19dfcd305ec37c1a3537238f4ce8798fc56f4d58ee0f8a7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/889be222a6ec2ac99381a46549055309cc3b1a2112a1f8899b7bb477e8a297b14acc59e34e51a6f407e34ad5ae7e7810df5fe58d039312cd03ddeb65c4d52546"} 14:52:07 INFO - Running post-run listener: copy_logs_to_upload_dir 14:52:07 INFO - Copying logs to upload dir... 14:52:07 INFO - mkdir: /builds/slave/test/build/upload/logs 14:52:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.495636 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-20 14:52:06.849722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:06.853559) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181 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/f44670cc887aef28d8d27e9e92773d96f2e15178bcc2fdd5ac6835ac0e6dfc794c419d7c3322fcfa19dfcd305ec37c1a3537238f4ce8798fc56f4d58ee0f8a7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/889be222a6ec2ac99381a46549055309cc3b1a2112a1f8899b7bb477e8a297b14acc59e34e51a6f407e34ad5ae7e7810df5fe58d039312cd03ddeb65c4d52546"} build_url:https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f44670cc887aef28d8d27e9e92773d96f2e15178bcc2fdd5ac6835ac0e6dfc794c419d7c3322fcfa19dfcd305ec37c1a3537238f4ce8798fc56f4d58ee0f8a7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/889be222a6ec2ac99381a46549055309cc3b1a2112a1f8899b7bb477e8a297b14acc59e34e51a6f407e34ad5ae7e7810df5fe58d039312cd03ddeb65c4d52546"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:06.880355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:06.880687) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461186970.134994-1458473181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004759 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:06.963985) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:52:06.964321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:52:06.964640) ========= ========= Total master_lag: 0.19 =========