builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1460888593.19 results: success (0) buildid: 20160417004052 builduid: 335ad8fefb6d4ce6b28cd91821b98e02 revision: 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:13.190066) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:13.190560) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:13.191175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:13.221680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:13.222208) ========= 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=836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-17 03:23:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-04-17 03:23:15 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121994 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:13.369967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:13.370298) ========= 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=836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021676 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:13.426873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:13.427240) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 --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 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 --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=836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-17 03:23:15,277 truncating revision to first 12 chars 2016-04-17 03:23:15,277 Setting DEBUG logging. 2016-04-17 03:23:15,277 attempt 1/10 2016-04-17 03:23:15,277 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/02b8dc35ec80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-17 03:23:15,669 unpacking tar archive at: mozilla-aurora-02b8dc35ec80/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716375 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:14.160076) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:14.160411) ========= script_repo_revision: 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:14.160840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:14.161144) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 03:23:14.174120) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-17 03:23:14.187485) ========= /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=836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:23:16 INFO - MultiFileLogger online at 20160417 03:23:16 in /builds/slave/test 03:23:16 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 03:23:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:23:16 INFO - {'append_to_log': False, 03:23:16 INFO - 'base_work_dir': '/builds/slave/test', 03:23:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:23:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:23:16 INFO - 'branch': 'Mozilla-Aurora', 03:23:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:23:16 INFO - 'config_files': ('talos/linux_config.py',), 03:23:16 INFO - 'default_actions': ('clobber', 03:23:16 INFO - 'read-buildbot-config', 03:23:16 INFO - 'download-and-extract', 03:23:16 INFO - 'populate-webroot', 03:23:16 INFO - 'create-virtualenv', 03:23:16 INFO - 'install', 03:23:16 INFO - 'run-tests'), 03:23:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:23:16 INFO - 'download_minidump_stackwalk': True, 03:23:16 INFO - 'download_symbols': 'ondemand', 03:23:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:23:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:23:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:23:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:23:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:23:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:23:16 INFO - 'installer_path': 'installer.exe', 03:23:16 INFO - 'log_level': 'info', 03:23:16 INFO - 'log_name': 'talos', 03:23:16 INFO - 'log_to_console': True, 03:23:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:23:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:23:16 INFO - 'opt_config_files': (), 03:23:16 INFO - 'pip_index': False, 03:23:16 INFO - 'sps_profile': False, 03:23:16 INFO - 'sps_profile_interval': 0, 03:23:16 INFO - 'suite': 'dromaeojs', 03:23:16 INFO - 'system_bits': '32', 03:23:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:23:16 INFO - 'title': 'talos-linux64-ix-028', 03:23:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:23:16 INFO - 'use_talos_json': True, 03:23:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:23:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:23:16 INFO - 'work_dir': 'build'} 03:23:16 INFO - ##### 03:23:16 INFO - ##### Running clobber step. 03:23:16 INFO - ##### 03:23:16 INFO - Running pre-action listener: _resource_record_pre_action 03:23:16 INFO - Running main action method: clobber 03:23:16 INFO - rmtree: /builds/slave/test/build 03:23:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:23:16 INFO - Running post-action listener: _resource_record_post_action 03:23:16 INFO - ##### 03:23:16 INFO - ##### Running read-buildbot-config step. 03:23:16 INFO - ##### 03:23:16 INFO - Running pre-action listener: _resource_record_pre_action 03:23:16 INFO - Running main action method: read_buildbot_config 03:23:16 INFO - Using buildbot properties: 03:23:16 INFO - { 03:23:16 INFO - "project": "", 03:23:16 INFO - "product": "firefox", 03:23:16 INFO - "script_repo_revision": "production", 03:23:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:23:16 INFO - "repository": "", 03:23:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:23:16 INFO - "buildid": "20160417004052", 03:23:16 INFO - "stage_platform": "linux64-pgo", 03:23:16 INFO - "basedir": "/builds/slave/test", 03:23:16 INFO - "nightly_build": "True", 03:23:16 INFO - "buildnumber": 440, 03:23:16 INFO - "slavename": "talos-linux64-ix-028", 03:23:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:23:16 INFO - "platform": "ubuntu64_hw", 03:23:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:23:16 INFO - "branch": "mozilla-aurora", 03:23:16 INFO - "repo_path": "releases/mozilla-aurora", 03:23:16 INFO - "revision": "02b8dc35ec80a95dd4f1cdd5a4075718aed233f2", 03:23:16 INFO - "pgo_build": "True", 03:23:16 INFO - "builduid": "335ad8fefb6d4ce6b28cd91821b98e02", 03:23:16 INFO - "slavebuilddir": "test" 03:23:16 INFO - } 03:23:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:23:16 INFO - Running post-action listener: _resource_record_post_action 03:23:16 INFO - ##### 03:23:16 INFO - ##### Running download-and-extract step. 03:23:16 INFO - ##### 03:23:16 INFO - Running pre-action listener: _resource_record_pre_action 03:23:16 INFO - Running main action method: download_and_extract 03:23:16 INFO - mkdir: /builds/slave/test/build/tests 03:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:16 INFO - https://queue.taskcluster.net/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:23:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:23:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:23:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/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 03:23:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/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 03:23:19 INFO - Downloaded 1448 bytes. 03:23:19 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:23:19 INFO - Using the following test package requirements: 03:23:19 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:23:19 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:23:19 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:23:19 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:19 INFO - u'jsshell-linux-x86_64.zip'], 03:23:19 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:23:19 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:23:19 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:23:19 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:23:19 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:23:19 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:23:19 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:23:19 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:19 INFO - https://queue.taskcluster.net/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/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 03:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/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 03:23:20 INFO - Downloaded 23352498 bytes. 03:23:20 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'] 03:23:20 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 03:23:21 INFO - Return code: 0 03:23:21 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 03:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:21 INFO - https://queue.taskcluster.net/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:23:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:23:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:23:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/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 03:23:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/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 03:23:38 INFO - Downloaded 23352498 bytes. 03:23:38 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'] 03:23:38 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 03:23:40 INFO - Return code: 0 03:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:40 INFO - https://queue.taskcluster.net/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/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 03:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/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 03:23:41 INFO - Downloaded 10845168 bytes. 03:23:41 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'] 03:23:41 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 03:23:41 INFO - Return code: 0 03:23: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')]} 03:23:41 INFO - https://queue.taskcluster.net/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:23:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:23:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:23:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/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 03:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fdtd7H8eT0aALYEJWlWKsA/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 03:23:42 INFO - Downloaded 60588913 bytes. 03:23:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:23:42 INFO - mkdir: /builds/slave/test/properties 03:23:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:23:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:23:42 INFO - Contents: 03:23:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:23:43 INFO - Running post-action listener: _resource_record_post_action 03:23:43 INFO - Running post-action listener: set_extra_try_arguments 03:23:43 INFO - ##### 03:23:43 INFO - ##### Running populate-webroot step. 03:23:43 INFO - ##### 03:23:43 INFO - Running pre-action listener: _resource_record_pre_action 03:23:43 INFO - Running main action method: populate_webroot 03:23:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:23:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:23:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:23:43 INFO - '--tppagecycles', 03:23:43 INFO - '7'], 03:23:43 INFO - 'tests': ['tsvgm']}}, 03:23:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:23:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:23:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:23:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:23:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:23:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:23:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:43 INFO - 'talos_options': ['--e10s'], 03:23:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:43 INFO - 'tests': ['damp', 'tps']}, 03:23:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:43 INFO - 'talos_options': ['--e10s'], 03:23:43 INFO - 'tests': ['damp', 'tps']}, 03:23:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:23:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:23:43 INFO - 'other': {'tests': ['a11yr', 03:23:43 INFO - 'ts_paint', 03:23:43 INFO - 'tpaint', 03:23:43 INFO - 'sessionrestore', 03:23:43 INFO - 'sessionrestore_no_auto_restore', 03:23:43 INFO - 'tabpaint']}, 03:23:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:23:43 INFO - 'tests': ['a11yr', 03:23:43 INFO - 'ts_paint', 03:23:43 INFO - 'tpaint', 03:23:43 INFO - 'sessionrestore', 03:23:43 INFO - 'sessionrestore_no_auto_restore', 03:23:43 INFO - 'tabpaint']}, 03:23:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:23:43 INFO - 'tests': ['a11yr', 03:23:43 INFO - 'ts_paint', 03:23:43 INFO - 'tpaint', 03:23:43 INFO - 'sessionrestore', 03:23:43 INFO - 'sessionrestore_no_auto_restore', 03:23:43 INFO - 'tabpaint']}, 03:23:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:23:43 INFO - 'tests': ['a11yr', 03:23:43 INFO - 'ts_paint', 03:23:43 INFO - 'tpaint', 03:23:43 INFO - 'sessionrestore', 03:23:43 INFO - 'sessionrestore_no_auto_restore', 03:23:43 INFO - 'tabpaint']}, 03:23:43 INFO - 'other_l64': {'tests': ['a11yr', 03:23:43 INFO - 'ts_paint', 03:23:43 INFO - 'tpaint', 03:23:43 INFO - 'sessionrestore', 03:23:43 INFO - 'sessionrestore_no_auto_restore', 03:23:43 INFO - 'tabpaint']}, 03:23:43 INFO - 'other_nol64': {'tests': ['a11yr', 03:23:43 INFO - 'ts_paint', 03:23:43 INFO - 'tpaint', 03:23:43 INFO - 'sessionrestore', 03:23:43 INFO - 'sessionrestore_no_auto_restore', 03:23:43 INFO - 'tabpaint']}, 03:23:43 INFO - 'svgr': {'tests': ['tsvgx', 03:23:43 INFO - 'tsvgr_opacity', 03:23:43 INFO - 'tart', 03:23:43 INFO - 'tscrollx', 03:23:43 INFO - 'cart']}, 03:23:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:23:43 INFO - 'tests': ['tsvgx', 03:23:43 INFO - 'tsvgr_opacity', 03:23:43 INFO - 'tart', 03:23:43 INFO - 'tscrollx', 03:23:43 INFO - 'cart']}, 03:23:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:43 INFO - 'tests': ['tp5o']}, 03:23:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:43 INFO - 'talos_options': ['--e10s'], 03:23:43 INFO - 'tests': ['tp5o']}, 03:23:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:43 INFO - 'talos_options': ['--xperf_path', 03:23:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:43 INFO - 'tests': ['tp5n']}, 03:23:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:43 INFO - 'talos_options': ['--e10s', 03:23:43 INFO - '--xperf_path', 03:23:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:43 INFO - 'tests': ['tp5n']}}, 03:23:43 INFO - 'talos.zip': {'path': '', 03:23:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:23:43 INFO - Running post-action listener: _resource_record_post_action 03:23:43 INFO - ##### 03:23:43 INFO - ##### Running create-virtualenv step. 03:23:43 INFO - ##### 03:23:43 INFO - Running pre-action listener: _resource_record_pre_action 03:23:43 INFO - Running main action method: create_virtualenv 03:23:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:23:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:23:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:23:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:23:43 INFO - Using real prefix '/usr' 03:23:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:23:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:46 INFO - Installing pip.................done. 03:23:46 INFO - Return code: 0 03:23:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:46 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 0x7f1ac4283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a160>, '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 0x1e6b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b4f0>, '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': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:23:46 INFO - Using env: {'DISPLAY': ':0', 03:23:46 INFO - 'HOME': '/home/cltbld', 03:23:46 INFO - 'LANG': 'en_US.UTF-8', 03:23:46 INFO - 'LANGUAGE': 'en_US:en', 03:23:46 INFO - 'LOGNAME': 'cltbld', 03:23:46 INFO - 'MAIL': '/var/mail/cltbld', 03:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:46 INFO - 'MOZ_NO_REMOTE': '1', 03:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:46 INFO - 'NO_EM_RESTART': '1', 03:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:46 INFO - 'PWD': '/builds/slave/test', 03:23:46 INFO - 'SHELL': '/bin/bash', 03:23:46 INFO - 'SHLVL': '1', 03:23:46 INFO - 'TERM': 'linux', 03:23:46 INFO - 'TMOUT': '86400', 03:23:46 INFO - 'USER': 'cltbld', 03:23:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 03:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:46 INFO - '_': '/tools/buildbot/bin/python'} 03:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:23:46 INFO - Cleaning up... 03:23:46 INFO - Return code: 0 03:23:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:46 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 0x7f1ac4283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a160>, '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 0x1e6b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b4f0>, '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': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:23:46 INFO - Using env: {'DISPLAY': ':0', 03:23:46 INFO - 'HOME': '/home/cltbld', 03:23:46 INFO - 'LANG': 'en_US.UTF-8', 03:23:46 INFO - 'LANGUAGE': 'en_US:en', 03:23:46 INFO - 'LOGNAME': 'cltbld', 03:23:46 INFO - 'MAIL': '/var/mail/cltbld', 03:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:46 INFO - 'MOZ_NO_REMOTE': '1', 03:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:46 INFO - 'NO_EM_RESTART': '1', 03:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:46 INFO - 'PWD': '/builds/slave/test', 03:23:46 INFO - 'SHELL': '/bin/bash', 03:23:46 INFO - 'SHLVL': '1', 03:23:46 INFO - 'TERM': 'linux', 03:23:46 INFO - 'TMOUT': '86400', 03:23:46 INFO - 'USER': 'cltbld', 03:23:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 03:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:46 INFO - '_': '/tools/buildbot/bin/python'} 03:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:46 INFO - Downloading/unpacking psutil>=0.7.1 03:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:48 INFO - Installing collected packages: psutil 03:23:48 INFO - Running setup.py install for psutil 03:23:48 INFO - building 'psutil._psutil_linux' extension 03:23:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:23:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:23:49 INFO - building 'psutil._psutil_posix' extension 03:23:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:23:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:23:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:49 INFO - Successfully installed psutil 03:23:49 INFO - Cleaning up... 03:23:49 INFO - Return code: 0 03:23:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:49 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 0x7f1ac4283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a160>, '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 0x1e6b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b4f0>, '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': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:23:49 INFO - Using env: {'DISPLAY': ':0', 03:23:49 INFO - 'HOME': '/home/cltbld', 03:23:49 INFO - 'LANG': 'en_US.UTF-8', 03:23:49 INFO - 'LANGUAGE': 'en_US:en', 03:23:49 INFO - 'LOGNAME': 'cltbld', 03:23:49 INFO - 'MAIL': '/var/mail/cltbld', 03:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:49 INFO - 'MOZ_NO_REMOTE': '1', 03:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:49 INFO - 'NO_EM_RESTART': '1', 03:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:49 INFO - 'PWD': '/builds/slave/test', 03:23:49 INFO - 'SHELL': '/bin/bash', 03:23:49 INFO - 'SHLVL': '1', 03:23:49 INFO - 'TERM': 'linux', 03:23:49 INFO - 'TMOUT': '86400', 03:23:49 INFO - 'USER': 'cltbld', 03:23:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 03:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:49 INFO - '_': '/tools/buildbot/bin/python'} 03:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:23:51 INFO - Installing collected packages: mozsystemmonitor 03:23:51 INFO - Running setup.py install for mozsystemmonitor 03:23:51 INFO - Successfully installed mozsystemmonitor 03:23:51 INFO - Cleaning up... 03:23:51 INFO - Return code: 0 03:23:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:51 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 0x7f1ac4283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a160>, '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 0x1e6b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b4f0>, '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': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:23:51 INFO - Using env: {'DISPLAY': ':0', 03:23:51 INFO - 'HOME': '/home/cltbld', 03:23:51 INFO - 'LANG': 'en_US.UTF-8', 03:23:51 INFO - 'LANGUAGE': 'en_US:en', 03:23:51 INFO - 'LOGNAME': 'cltbld', 03:23:51 INFO - 'MAIL': '/var/mail/cltbld', 03:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:51 INFO - 'MOZ_NO_REMOTE': '1', 03:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:51 INFO - 'NO_EM_RESTART': '1', 03:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:51 INFO - 'PWD': '/builds/slave/test', 03:23:51 INFO - 'SHELL': '/bin/bash', 03:23:51 INFO - 'SHLVL': '1', 03:23:51 INFO - 'TERM': 'linux', 03:23:51 INFO - 'TMOUT': '86400', 03:23:51 INFO - 'USER': 'cltbld', 03:23:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 03:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:51 INFO - '_': '/tools/buildbot/bin/python'} 03:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:54 INFO - Downloading docopt-0.6.1.tar.gz 03:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:54 INFO - Running setup.py install for blobuploader 03:23:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:54 INFO - Running setup.py install for requests 03:23:54 INFO - Running setup.py install for docopt 03:23:55 INFO - Successfully installed blobuploader requests docopt 03:23:55 INFO - Cleaning up... 03:23:55 INFO - Return code: 0 03:23:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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')]} 03:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:55 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 0x7f1ac4283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a160>, '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 0x1e6b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b4f0>, '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': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:55 INFO - Using env: {'DISPLAY': ':0', 03:23:55 INFO - 'HOME': '/home/cltbld', 03:23:55 INFO - 'LANG': 'en_US.UTF-8', 03:23:55 INFO - 'LANGUAGE': 'en_US:en', 03:23:55 INFO - 'LOGNAME': 'cltbld', 03:23:55 INFO - 'MAIL': '/var/mail/cltbld', 03:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:55 INFO - 'MOZ_NO_REMOTE': '1', 03:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:55 INFO - 'NO_EM_RESTART': '1', 03:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:55 INFO - 'PWD': '/builds/slave/test', 03:23:55 INFO - 'SHELL': '/bin/bash', 03:23:55 INFO - 'SHLVL': '1', 03:23:55 INFO - 'TERM': 'linux', 03:23:55 INFO - 'TMOUT': '86400', 03:23:55 INFO - 'USER': 'cltbld', 03:23:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 03:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:55 INFO - '_': '/tools/buildbot/bin/python'} 03:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:55 INFO - Running setup.py (path:/tmp/pip-9F6l_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:55 INFO - Running setup.py (path:/tmp/pip-AcrMHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:55 INFO - Running setup.py (path:/tmp/pip-1DenDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:55 INFO - Running setup.py (path:/tmp/pip-GzqWZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:55 INFO - Running setup.py (path:/tmp/pip-_VUftf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:55 INFO - Running setup.py (path:/tmp/pip-I4x108-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:55 INFO - Running setup.py (path:/tmp/pip-tdJsEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:55 INFO - Running setup.py (path:/tmp/pip-S0yA1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:55 INFO - Running setup.py (path:/tmp/pip-CTKt99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:55 INFO - Running setup.py (path:/tmp/pip-uLo5xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:56 INFO - Running setup.py (path:/tmp/pip-AqYPDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:56 INFO - Running setup.py (path:/tmp/pip-C_pSXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:56 INFO - Running setup.py (path:/tmp/pip-Oc4AzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:56 INFO - Running setup.py (path:/tmp/pip-i2Rxpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:56 INFO - Running setup.py (path:/tmp/pip-PMFwIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:56 INFO - Running setup.py (path:/tmp/pip-AkEz41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:56 INFO - Running setup.py (path:/tmp/pip-84aVm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:56 INFO - Running setup.py install for manifestparser 03:23:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:56 INFO - Running setup.py install for mozcrash 03:23:56 INFO - Running setup.py install for mozdebug 03:23:56 INFO - Running setup.py install for mozdevice 03:23:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:23:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:56 INFO - Running setup.py install for mozfile 03:23:57 INFO - Running setup.py install for mozhttpd 03:23:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Running setup.py install for mozinfo 03:23:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Running setup.py install for mozInstall 03:23:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Running setup.py install for mozleak 03:23:57 INFO - Running setup.py install for mozlog 03:23:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Running setup.py install for moznetwork 03:23:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Running setup.py install for mozprocess 03:23:57 INFO - Running setup.py install for mozprofile 03:23:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Running setup.py install for mozrunner 03:23:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:57 INFO - Running setup.py install for mozscreenshot 03:23:58 INFO - Running setup.py install for moztest 03:23:58 INFO - Running setup.py install for mozversion 03:23:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:58 INFO - Cleaning up... 03:23:58 INFO - Return code: 0 03:23:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:58 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 0x7f1ac4283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a160>, '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 0x1e6b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b4f0>, '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': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:58 INFO - Using env: {'DISPLAY': ':0', 03:23:58 INFO - 'HOME': '/home/cltbld', 03:23:58 INFO - 'LANG': 'en_US.UTF-8', 03:23:58 INFO - 'LANGUAGE': 'en_US:en', 03:23:58 INFO - 'LOGNAME': 'cltbld', 03:23:58 INFO - 'MAIL': '/var/mail/cltbld', 03:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:58 INFO - 'MOZ_NO_REMOTE': '1', 03:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:58 INFO - 'NO_EM_RESTART': '1', 03:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:58 INFO - 'PWD': '/builds/slave/test', 03:23:58 INFO - 'SHELL': '/bin/bash', 03:23:58 INFO - 'SHLVL': '1', 03:23:58 INFO - 'TERM': 'linux', 03:23:58 INFO - 'TMOUT': '86400', 03:23:58 INFO - 'USER': 'cltbld', 03:23:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 03:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:58 INFO - '_': '/tools/buildbot/bin/python'} 03:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:58 INFO - Running setup.py (path:/tmp/pip-U3EL9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:58 INFO - Running setup.py (path:/tmp/pip-e_iHeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:58 INFO - Running setup.py (path:/tmp/pip-RpkaEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:58 INFO - Running setup.py (path:/tmp/pip-rshxlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:58 INFO - Running setup.py (path:/tmp/pip-1qWVwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:58 INFO - Running setup.py (path:/tmp/pip-Z0ky_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:58 INFO - Running setup.py (path:/tmp/pip-TofhHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:59 INFO - Running setup.py (path:/tmp/pip-F_Qa6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:59 INFO - Running setup.py (path:/tmp/pip-F3YFpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:59 INFO - Running setup.py (path:/tmp/pip-iKHDKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:59 INFO - Running setup.py (path:/tmp/pip-XkOfiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:59 INFO - Running setup.py (path:/tmp/pip-RrXQKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:59 INFO - Running setup.py (path:/tmp/pip-K1udSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:59 INFO - Running setup.py (path:/tmp/pip-Nj1V1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:59 INFO - Running setup.py (path:/tmp/pip-q_3t1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:59 INFO - Running setup.py (path:/tmp/pip-try8nG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:59 INFO - Running setup.py (path:/tmp/pip-JCOxO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:24:01 INFO - Downloading blessings-1.6.tar.gz 03:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:24:01 INFO - Installing collected packages: blessings 03:24:01 INFO - Running setup.py install for blessings 03:24:01 INFO - Successfully installed blessings 03:24:01 INFO - Cleaning up... 03:24:01 INFO - Return code: 0 03:24:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:24:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:02 INFO - Reading from file tmpfile_stdout 03:24:02 INFO - Current package versions: 03:24:02 INFO - argparse == 1.2.1 03:24:02 INFO - blessings == 1.6 03:24:02 INFO - blobuploader == 1.2.4 03:24:02 INFO - docopt == 0.6.1 03:24:02 INFO - manifestparser == 1.1 03:24:02 INFO - mozInstall == 1.12 03:24:02 INFO - mozcrash == 0.17 03:24:02 INFO - mozdebug == 0.1 03:24:02 INFO - mozdevice == 0.48 03:24:02 INFO - mozfile == 1.2 03:24:02 INFO - mozhttpd == 0.7 03:24:02 INFO - mozinfo == 0.9 03:24:02 INFO - mozleak == 0.1 03:24:02 INFO - mozlog == 3.1 03:24:02 INFO - moznetwork == 0.27 03:24:02 INFO - mozprocess == 0.22 03:24:02 INFO - mozprofile == 0.28 03:24:02 INFO - mozrunner == 6.11 03:24:02 INFO - mozscreenshot == 0.1 03:24:02 INFO - mozsystemmonitor == 0.0 03:24:02 INFO - moztest == 0.7 03:24:02 INFO - mozversion == 1.4 03:24:02 INFO - psutil == 3.1.1 03:24:02 INFO - requests == 1.2.3 03:24:02 INFO - wsgiref == 0.1.2 03:24:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:02 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 0x7f1ac4283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a160>, '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 0x1e6b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b4f0>, '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': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:24:02 INFO - Using env: {'DISPLAY': ':0', 03:24:02 INFO - 'HOME': '/home/cltbld', 03:24:02 INFO - 'LANG': 'en_US.UTF-8', 03:24:02 INFO - 'LANGUAGE': 'en_US:en', 03:24:02 INFO - 'LOGNAME': 'cltbld', 03:24:02 INFO - 'MAIL': '/var/mail/cltbld', 03:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:02 INFO - 'MOZ_NO_REMOTE': '1', 03:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:02 INFO - 'NO_EM_RESTART': '1', 03:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:02 INFO - 'PWD': '/builds/slave/test', 03:24:02 INFO - 'SHELL': '/bin/bash', 03:24:02 INFO - 'SHLVL': '1', 03:24:02 INFO - 'TERM': 'linux', 03:24:02 INFO - 'TMOUT': '86400', 03:24:02 INFO - 'USER': 'cltbld', 03:24:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 03:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:02 INFO - '_': '/tools/buildbot/bin/python'} 03:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:24:02 INFO - Cleaning up... 03:24:02 INFO - Return code: 0 03:24:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:02 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 0x7f1ac4283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a160>, '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 0x1e6b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b4f0>, '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': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:24:02 INFO - Using env: {'DISPLAY': ':0', 03:24:02 INFO - 'HOME': '/home/cltbld', 03:24:02 INFO - 'LANG': 'en_US.UTF-8', 03:24:02 INFO - 'LANGUAGE': 'en_US:en', 03:24:02 INFO - 'LOGNAME': 'cltbld', 03:24:02 INFO - 'MAIL': '/var/mail/cltbld', 03:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:02 INFO - 'MOZ_NO_REMOTE': '1', 03:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:02 INFO - 'NO_EM_RESTART': '1', 03:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:02 INFO - 'PWD': '/builds/slave/test', 03:24:02 INFO - 'SHELL': '/bin/bash', 03:24:02 INFO - 'SHLVL': '1', 03:24:02 INFO - 'TERM': 'linux', 03:24:02 INFO - 'TMOUT': '86400', 03:24:02 INFO - 'USER': 'cltbld', 03:24:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 03:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:02 INFO - '_': '/tools/buildbot/bin/python'} 03:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:02 INFO - Downloading/unpacking jsonschema 03:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:24:04 INFO - Downloading/unpacking functools32 (from jsonschema) 03:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:04 INFO - Downloading functools32-3.2.3-2.tar.gz 03:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:24:04 INFO - warning: no files found matching '*.txt' 03:24:04 INFO - no previously-included directories found matching 'build' 03:24:04 INFO - no previously-included directories found matching 'dist' 03:24:04 INFO - no previously-included directories found matching '.git*' 03:24:04 INFO - Installing collected packages: jsonschema, functools32 03:24:04 INFO - Running setup.py install for functools32 03:24:04 INFO - warning: no files found matching '*.txt' 03:24:04 INFO - no previously-included directories found matching 'build' 03:24:04 INFO - no previously-included directories found matching 'dist' 03:24:04 INFO - no previously-included directories found matching '.git*' 03:24:04 INFO - Successfully installed jsonschema functools32 03:24:04 INFO - Cleaning up... 03:24:04 INFO - Return code: 0 03:24:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:24: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')]} 03:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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')]} 03:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1ac4283f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a160>, '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 0x1e6b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b4f0>, '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': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:24:04 INFO - Using env: {'DISPLAY': ':0', 03:24:04 INFO - 'HOME': '/home/cltbld', 03:24:04 INFO - 'LANG': 'en_US.UTF-8', 03:24:04 INFO - 'LANGUAGE': 'en_US:en', 03:24:04 INFO - 'LOGNAME': 'cltbld', 03:24:04 INFO - 'MAIL': '/var/mail/cltbld', 03:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:04 INFO - 'MOZ_NO_REMOTE': '1', 03:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:04 INFO - 'NO_EM_RESTART': '1', 03:24:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:04 INFO - 'PWD': '/builds/slave/test', 03:24:04 INFO - 'SHELL': '/bin/bash', 03:24:04 INFO - 'SHLVL': '1', 03:24:04 INFO - 'TERM': 'linux', 03:24:04 INFO - 'TMOUT': '86400', 03:24:04 INFO - 'USER': 'cltbld', 03:24:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 03:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:04 INFO - '_': '/tools/buildbot/bin/python'} 03:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:05 INFO - Downloading/unpacking flake8 03:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:24:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:24:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:24:07 INFO - no previously-included directories found matching 'docs/_build' 03:24:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:24:08 INFO - Running setup.py install for pep8 03:24:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:24:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:24:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:24:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:24:08 INFO - no previously-included directories found matching 'docs/_build' 03:24:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:24:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:24:08 INFO - Cleaning up... 03:24:08 INFO - Return code: 0 03:24:08 INFO - Running post-action listener: _resource_record_post_action 03:24:08 INFO - Running post-action listener: _start_resource_monitoring 03:24:08 INFO - Starting resource monitoring. 03:24:08 INFO - ##### 03:24:08 INFO - ##### Running install step. 03:24:08 INFO - ##### 03:24:08 INFO - Running pre-action listener: _resource_record_pre_action 03:24:08 INFO - Running main action method: install 03:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:08 INFO - Reading from file tmpfile_stdout 03:24:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:24:08 INFO - Reading from file tmpfile_stdout 03:24:08 INFO - Output received: 03:24:08 INFO - Usage: mozinstall [options] installer 03:24:08 INFO - Options: 03:24:08 INFO - -h, --help show this help message and exit 03:24:08 INFO - -d DEST, --destination=DEST 03:24:08 INFO - Directory to install application into. [default: 03:24:08 INFO - "/builds/slave/test"] 03:24:08 INFO - --app=APP Application being installed. [default: firefox] 03:24:08 INFO - mkdir: /builds/slave/test/build/application 03:24:08 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'] 03:24:08 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 03:24:23 INFO - Reading from file tmpfile_stdout 03:24:23 INFO - Output received: 03:24:23 INFO - /builds/slave/test/build/application/firefox/firefox 03:24:23 INFO - Running post-action listener: _resource_record_post_action 03:24:23 INFO - ##### 03:24:23 INFO - ##### Running run-tests step. 03:24:23 INFO - ##### 03:24:23 INFO - Running pre-action listener: _resource_record_pre_action 03:24:23 INFO - Running main action method: run_tests 03:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:23 INFO - Python 2.7.3 03:24:23 INFO - Return code: 0 03:24:23 INFO - grabbing minidump binary from tooltool 03:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:23 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 0x1e6a160>, '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 0x1e6b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:24:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:24:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:23 INFO - Return code: 0 03:24:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:24:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:24:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:24:24 INFO - Return code: 0 03:24:24 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/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 03:24:24 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/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 03:24:24 INFO - Using env: {'DISPLAY': ':0', 03:24:24 INFO - 'HOME': '/home/cltbld', 03:24:24 INFO - 'LANG': 'en_US.UTF-8', 03:24:24 INFO - 'LANGUAGE': 'en_US:en', 03:24:24 INFO - 'LOGNAME': 'cltbld', 03:24:24 INFO - 'MAIL': '/var/mail/cltbld', 03:24:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:24 INFO - 'MOZ_NO_REMOTE': '1', 03:24:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:24 INFO - 'NO_EM_RESTART': '1', 03:24:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:24 INFO - 'PWD': '/builds/slave/test', 03:24:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:24 INFO - 'SHELL': '/bin/bash', 03:24:24 INFO - 'SHLVL': '1', 03:24:24 INFO - 'TERM': 'linux', 03:24:24 INFO - 'TMOUT': '86400', 03:24:24 INFO - 'USER': 'cltbld', 03:24:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128', 03:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:24 INFO - '_': '/tools/buildbot/bin/python'} 03:24:24 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/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 03:24:24 INFO - mozversion application_buildid: 20160417004052 03:24:24 INFO - mozversion application_changeset: 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 03:24:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:24:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:24:24 INFO - mozversion application_name: Firefox 03:24:24 INFO - mozversion application_remotingname: firefox-dev 03:24:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:24:24 INFO - mozversion application_vendor: Mozilla 03:24:24 INFO - mozversion application_version: 47.0a2 03:24:24 INFO - mozversion platform_buildid: 20160417004052 03:24:24 INFO - mozversion platform_changeset: 02b8dc35ec80a95dd4f1cdd5a4075718aed233f2 03:24:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:24:24 INFO - mozversion platform_version: 47.0a2 03:24:24 INFO - using testdate: 1460888664 03:24:24 INFO - actual date: 1460888664 03:24:24 INFO - starting webserver on 'localhost:51384' 03:24:24 INFO - SUITE-START | Running 2 tests 03:24:24 INFO - TEST-START | dromaeo_css 03:24:24 INFO - operating with platform_type : linux_ 03:24:24 INFO - Initialising browser for dromaeo_css test... 03:24:24 INFO - TEST-INFO | started process 30427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOQ88_b/profile http://localhost:51384/getInfo.html) 03:24:29 INFO - PROCESS | 30427 | __metrics Screen width/height:1600/1200 03:24:29 INFO - PROCESS | 30427 | colorDepth:24 03:24:29 INFO - PROCESS | 30427 | Browser inner width/height: 1024/697 03:24:29 INFO - PROCESS | 30427 | __metrics 03:24:30 INFO - PROCESS | 30427 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:24:31 INFO - TEST-INFO | 30427: exit 0 03:24:31 INFO - Browser initialized. 03:24:31 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:31 INFO - TEST-INFO | started process 30516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOQ88_b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:43 INFO - PROCESS | 30516 | RSS: Main: 141570048 03:24:43 INFO - PROCESS | 30516 | 03:25:34 INFO - PROCESS | 30516 | 1460888734069 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:27:41 INFO - PROCESS | 30516 | Cycle 1(1): loaded http://localhost:51384/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51384/tests/dromaeo/cssquery-ext.html) 03:27:42 INFO - PROCESS | 30516 | RSS: Main: 253308928 03:27:42 INFO - PROCESS | 30516 | 03:30:44 INFO - PROCESS | 30516 | Cycle 1(1): loaded http://localhost:51384/tests/dromaeo/cssquery-ext.html (next: http://localhost:51384/tests/dromaeo/cssquery-jquery.html) 03:30:45 INFO - PROCESS | 30516 | RSS: Main: 227831808 03:30:45 INFO - PROCESS | 30516 | 03:33:47 INFO - PROCESS | 30516 | Cycle 1(1): loaded http://localhost:51384/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51384/tests/dromaeo/cssquery-mootools.html) 03:33:47 INFO - PROCESS | 30516 | RSS: Main: 224534528 03:33:47 INFO - PROCESS | 30516 | 03:36:49 INFO - PROCESS | 30516 | Cycle 1(1): loaded http://localhost:51384/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51384/tests/dromaeo/cssquery-prototype.html) 03:36:50 INFO - PROCESS | 30516 | RSS: Main: 191660032 03:36:50 INFO - PROCESS | 30516 | 03:39:52 INFO - PROCESS | 30516 | Cycle 1(1): loaded http://localhost:51384/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51384/tests/dromaeo/cssquery-yui.html) 03:39:53 INFO - PROCESS | 30516 | RSS: Main: 212627456 03:39:53 INFO - PROCESS | 30516 | 03:42:55 INFO - PROCESS | 30516 | Cycle 1(1): loaded http://localhost:51384/tests/dromaeo/cssquery-yui.html (next: http://localhost:51384/tests/dromaeo/cssquery-dojo.html) 03:42:55 INFO - PROCESS | 30516 | RSS: Main: 259022848 03:42:55 INFO - PROCESS | 30516 | 03:42:55 INFO - PROCESS | 30516 | __start_tp_report 03:42:55 INFO - PROCESS | 30516 | _x_x_mozilla_page_load 03:42:55 INFO - PROCESS | 30516 | _x_x_mozilla_page_load_details 03:42:55 INFO - PROCESS | 30516 | |i|pagename|runs| 03:42:55 INFO - PROCESS | 30516 | |0;dojo.html;3223.113643747969;3265.8856940007104;3283.3269179818126;3290.128116049246;3323.3021065576227;5222.138347172712;5230.34620672416;5230.476952304777;5252.684838909663;5291.0211610851975;5216.426193118754;5240;5241.5020573045595;5247.107991641421;5278.947210527894;4692.741899195543;4824.276358546229;4827.8310259140935;4864.951350486485;4872.683275587093;4821.807127714887;4830.275458681208;4863.392075990501;4867;4867.2942423348595;4845.3216549683075;4856.6357523185725;4907.975460122694;4913.287573301869;4915.483874193212;4926.630502712275;4940.752962351886;4946.431160416562;4954.87612809679;4965.503449655042;4762.547557981986;4805.471398146201;4857.684250523705;4883.902321953577;4913.729744864031;5092.312537807423;5126.077306084903;5141.331626888518;5142.1772516397195;5160.690358578498;5566.944330556724;5567.554595632339;5708.800191993302;5729.541636669056;5731.254936858223;5685.800996965087;5738.454846789548;5747.626404283708;5756.7985120521;5771.336296325934;5267.499587539178;5285.68285902847;5286.60350473716;5288.0745869472685;5289.100852855024;5738.8278351649515;5740.6268592541355;5741.1388291756575;5836.88326233473;5923.378045305181;5631;5652.152177173375;5654.321481422174;5656;5660.8867822643315;5718.056520674042;5724.856878577985;5736.569757268138;5741.741621627037;5746.827595172068;5588.217649528988;5681.630694004876;5684.37471878093;5764.798232061941;5770.567207459458;5666.9716651416475;5671.546276297886;5679;5683.943160568341;5685.658860468385;4347.34789781529;4393.077453734688;4395.736255824597;4399.340098985178;4414.977925110354;3869.5356557213313;3896.1818018215927;3928.980355098206;3971.0667993021616;3977.940330895039;5363.946360536423;5397.298351214317;5412.91880621791;5419.105847535191;5453.700046497402;5533.916991245134;5712.400197979236;5717.199592057115;5717.656940583495;5718.599698021098;5350.9732451337495;5385.111456609616;5417.783288668409;5418.945810541923;5447.591430642638;4904.705717656952;4927.260910863399;4928.827491037797;4928.827491037868;4958.132326842788;5694.4590263924865;5793.449622285876;5836.2412886325355;5837;5863.296404431496;5689.374168841507;5734.598578099493;5753.165790960371;5761.337446193574;5793.884122317446;5916.763329466773;5935.584509084322;5941.31674857397;5944.494717949023;5947.940520594739;5409.78360865561;5510.366307874646;5543.6396634218645;5653.717314134359;5662;5736.856578585569;5739.311282645942;5745.339285982165;5751.079827227623;5752.798652047159;5563.972180139073;5609.27079479665;5610.074337734228;5610.270664813548;5613.607047506635;5345.78616855337;5517.972410137923;5583.972080139573;5592.5525957922455;5646.322441306905;5445.428230035947;5460.180972853945;5469.097598896137;5480.972595136999;5482.506574408322;5538.778448862;5569.10894256917;5583.860403489945;5588.804391846266;5603.467670571289;5295.258663786996;5301.920471193012;5417.539509141609;5520.861978450571;5536.889262214814 03:42:55 INFO - PROCESS | 30516 | |1;ext.html;550.1939658400443;576.9163471296665;579.6840721806615;590.8316129902978;595.3689089565061;30169.69830301699;30614.846925765367;30650.23374415641;42645.7867710661;44121;45994.31008534875;46021.539784602144;46578.76710616442;46667.29999050008;46803;9050.954745226281;9230.16928476437;9265.768355791126;9271.536423178848;9276.11876871696;9118.361714679975;9259.814803703923;9261.398009129418;9280.7679808005;9306;9304.11610896967;9413.952930235373;9416.340856140074;9416.62333506659;9419.905800941971;9230.630774769;9310;9314.115159059878;9318.673846415342;9319.813603727955;9186.908130918739;9335.439873607538;9345.205657519118;9346.626134954593;9350.859737103881;43983.56016439859;44697;44737.77631111856;44777;44877.32684009743;3808.276427478798;3829.63618456249;3971.5035620547433;4221.303484924983;4233.428487154226;30761.538576921364;30917.22706932322;31277.843610782027;31339;31864.203394915312;4213.705040647156;4294.26997410441;4298.677599180074;4404.163208990313;4431.135928493945;304510;309551;310134;310180;311303;47859.28211076836;71746.64126679333;73919;74183;74457;47519.287210691866;47864.04271914542;47866.760666196446;47895.28157077647;47962.28056579154;17022.82977170237;17256.65486690259;17269.222884970208;17293.221805018806;17303.56741081483;12749.68125796844;12768.361581921052;12806.935965320301;12810.9359453204;12812.743745125046;15808.367665293259;15854.682906341808;15874.285657145456;16515.091669958267;16701.49895503137;6280.434760871543;6340.651264180422;6383.425491705769;6453.290138084807;6460.289368169498;1011.9241056920613;1062.7661914378825;1081.2053140941402;1083.0019460191318;1088.548252475214;29447;29914.70085299119;30531.542026869614;31082.22294442657;31332;1126.3298337489182;1182.4400173624178;1186.928784272929;1235.215638069832;1241.8385609870659;15707.921460392625;15733;15817.089227905863;15968.680626387408;16203.756943645854;358346;363082;363658;364539;364831;59134.40865591375;59978;60041.39958600358;60186.699066504385;60271;1266.7656483550388;1406.3811922753955;1426.3367534096694;1491.246920305239;1591.856732894045;26863.597046043935;27347.969768672818;27377;27686;29889.701102988693;47400.28899566578;47463.762681186374;47752.7612361936;47772.761136194094;47824.52175478201;224785;227170;227945;228095;228229;30803.84598076995;35158.29683406369;35198.824005879804;35232.29535409329;35450;51804;52439.47560524346;52513.474865252385;53119;53135.73432132815;40288;40550;40655;41508.792456037525;41729.58270417257;39259;39378.40932386074;39689.60310396975;39707.40438893361;40534.594654054265;40069.1986160281;42487.15025699531;43044.13911721685;43178.35232471453;43627.345589815544;36006;36802.63197367992;39836.40245396379;39868.800655996536;40587.391189131595;27198.592021119304;27743.861280694277;27771.166864994084;27823;27860.860695696392 03:42:55 INFO - PROCESS | 30516 | |2;jquery.html;380.6449041412571;387.6143237478709;389.09535330356914;395.0439935356437;395.1839451532585;17433.476995690133;17561.473155805314;17948;17963.012034338124;18028.369007084755;17600.82399176011;17921.641567168648;18615.069246537685;18615.720764188514;18644.720329195072;5633.183188437664;5745.023346031185;5758.165066065418;5787;5788.6816225107605;5524;5626.184203290521;5668.914966275509;5702.258706368187;5715.885682286352;5609.467100625455;5619.859503512424;5653;5658.122990936411;5667.0932650775885;5353.464653534655;5483.150111732688;5569.610127291091;5570.805021824237;5582.581306402016;5268.1834315681135;5275.788968441258;5311.973440132813;5314.123169676998;5316;13827.861721382758;14319;21923.232686855885;21924.561508769893;22002.669959950614;2262.7171603549555;2493;2711.4983728010184;2994.5208766597457;3016.5173572228337;10085.596576136946;10232.795344093076;10420.218483613759;12428.502859885593;13951.720965580631;1723.4054251283287;1806.060848358846;1824.1973531646033;1833.367488216563;1915.82757551821;60771;60807.695961520796;60984.69507652433;61456.692716536134;61628;10249.487525623688;10444.68665940023;10543.156547476183;10932.704132132183;11030.22788404804;14563.271836408137;14676.266186690622;14684;14684.632884177981;14688.045277056957;7798;8055.516668999879;8109.189081091961;8120.878186827203;8194.344452443791;7849.686012559548;7852.764417067498;7896.131425543185;7921.32668723165;7971.123176450586;4712.64655150865;4717.481077081518;4729.668923175344;4743.146233677902;4758.262469317261;1793.7219730941563;1898.9715154272697;1912.2064343297375;1937.9515512112027;1964.79369666183;976.9511524423892;978.280963491833;979.4466126638426;1015.8933312002133;1046.2519298701466;16483.58791030234;16706.749398759028;16914.915425422794;17323;17462.56343591395;972.9416235025922;973.7176218896583;980.1717548671361;993.4486360070086;1056.0653821368144;9693.185445260156;10174.135198508062;10180.134688551409;10201.438920859424;10462.68611941643;427114;436106;436869;442565;443109;71370;74534;75402.24597753953;75455.62272188604;75477.62261188768;1012.6405126180247;1023.8668973033458;1027.7636143686993;1033.4316126130598;1058.5077938758513;15611.219439027776;15933;15953.202339882728;16121.113338766481;16149.434769783002;34407.827960860035;34940.301193976484;35054.29891402209;35781.46327805033;35790.64209357873;48436.5156348432;50392.49607503878;50459.495405045476;50554.49445505645;50655.24017139672;8437.071922088688;8486.448380855225;8506.957465212634;8678.609462574326;8716.477011379338;12424.130310878152;13270.668233294246;13386.598402047954;13516.93241533786;13570.185788852701;11392.601258955896;11426.314421134759;11506.82739758921;11745.530178793095;11769.646910592695;10964.28732132409;10985.670429887115;11126.221164518405;11140.33158010522;11231.326120432801;11692.824607631062;11849.940750296193;11858.822117668069;11996.58011969577;12083.516659333529;8383.496990180609;8408.705695300636;8499.787505312417;8608.913910861062;8687.39188256816;11044.723881903017;11330.716732081764;11346.432678366215;11399.487023084146;11454.656360309204 03:42:55 INFO - PROCESS | 30516 | |3;mootools.html;1404.452263617189;1571.9371225150994;1592.3869310315529;1764.7000009998299;1931.2275089964003;7581.545107293567;8151.755447336582;8316.085230624627;8343.415960882732;8344.541050242235;8221.136780638037;8409.57952102394;8413.36899732521;8428.747137585868;8444.282236009947;2096.4654013226605;2290.610596198642;2346.4133966508375;2351.1300818697105;2384.9642255366184;2401.3396316013063;2407.2296865003204;2408.7470815564375;2410.734819169899;2413.79482743967;2306.9307920762403;2365.124903785602;2365.6924599802087;2366.2428023032635;2370.0401337458356;2074.471009892475;2261.6720575516542;2284.725832900046;2290.7136607924094;2293.5298263856034;2264.62633665445;2271.454850835804;2280.783325584067;2281.0989659084566;2339.169594793858;8269.917300826975;8322.375821813388;8333.541655208961;8349.8330033399;8353.916460835375;4751.572358487718;4884.487128851455;4888.5111488850835;4897.804087836482;4961.032598643266;3142.607174103237;3178.9364212715845;3198.2643991881996;3215.099772063826;3218.8229647369385;934.2619330728717;934.700895713372;936.3445588088298;958.0132463562542;974.0600320690568;11725.061995040376;11812.70468238301;11821.290722556589;11821.763564728742;11833.408329583486;4409.779511024436;4473.597376236155;4537.795799189044;4560.771961401917;4578.885527861764;10042.146417554444;10066.848997265048;10067.043630855058;10089.293749437616;10102.949485252526;4680.648951328664;5083.288339632454;5127.154019586801;5135.12702840518;5137.948620513822;4530.909381812346;4588.88527786808;4593.678442509059;4607.262837945913;4607.815687372467;3808;3818.503594532693;3884.0484081400236;3893.766374017568;3905.3946638271113;1178.9705257368462;1231.4889320931893;1235.604606525921;1236.9319687417278;1244.7883859743683;1382.198324971514;1489.3074720255133;1498.707751988352;1507.70599733051;1513.8486151384773;8106.716264930699;8130.430869839054;8164.918350816416;8171.509709417454;8185.467944583583;483.04116329086736;499.62278479748284;501.22560643805406;505.4642079395852;510.5405135378189;6120.234970628671;6156.938430615636;6175.3515880832765;6230.719617617218;6237.313895471494;10035.548400322003;10295.53670084833;10396.48017599117;10555;10590.523426445829;10061.849072263922;10353.689389318333;10368.326058806153;10372.896271037192;10426.947865260625;8064.112947575762;8123.390745694097;8143.51138931666;8184.304334131546;8209.58952052395;7643;7801.45389822707;7804.9609751950875;7806.336461400618;7835.451518393886;9064.093590640883;9206.631734730803;9220.677276295297;9360.859587106062;9385.108414700593;9232.03063678331;9433.905660943577;9593.328467007243;9600;9650.372725772802;6729.327067293231;6949.200841903245;7092.574445533284;7506.28690274423;7619.619019048914;8159.143289954469;8160.714374996846;8181.3045891097545;8197.71308004241;8210.58947052633;7131.928680713334;7316.451266154953;7362.77911662651;7392.96303518479;7469.514481558681;7126.608036557832;7214.783556493314;7223.386012189023;7294.197638259681;7350.044494215717;7689.423293252917;7718.498297610638;7761.495502792526;7773.533587984739;7774.18371071052;6696.062551242732;6838.93161068383;6871.793846184622;6880.552764070319;6886.24251332343;7083.468739844429;7152.713891444284;7158.606276654834;7167.247439019036;7175.820604484929 03:42:55 INFO - PROCESS | 30516 | |4;prototype.html;347.8938923628293;350.1613635343352;363.9727020473465;367.6342039670528;379.34752226170974;5936.5250779937605;5964.701764911753;6038.5471089668345;6039.698015099244;6088.238970128734;5967.850803729909;5977.043673012319;5982.730777115029;5983.730732117055;6014.669193194372;4507.504174540798;4562.726236425809;4643.466001409847;4699.036697477026;4702.200625893606;4701.177293973541;4722.220833562458;4737.834175803848;4738.69198502098;4742.620590352763;4696.835610753625;4697.600703940169;4701.835435759749;4702.670813043088;4702.764861756916;4442.911141777163;4551.385562948993;4652.325412815123;4672.766361681936;4711;4193.874183774492;4205.936910946339;4205.957940420587;4214.262504061777;4214.7681877496725;5664.178694089334;5672.829815105553;5674.858128546778;5679.460451257124;5680.602357834953;5476.205950137248;5484.369297530795;5487.670739755627;5492.176173573956;5511.5039646432015;6369.93630063698;6376.330485299023;6383.2978372379;6384.170057892445;6388.936110638927;4360.6293465055505;4540.477845047829;4543.295789152687;4555.840545580922;4681.063787242531;6600.702968366435;6661.566998145105;6670.09953656255;6674.49941254403;6679.064930909628;4658.67227840064;4664.626829853603;4666.32338310943;4667.649926255544;4672.392588963413;4714.929276060861;4718.787654555554;4724.6456515760765;4734.21885388907;4734.573888350065;5406.91889621656;5408.621396502286;5410.377806552218;5424.077906755861;5427.050266203399;6258.43674069336;6384.744610215632;6386.840328991812;6406.839829004312;6408.359164083555;1619.9433019844485;1645.7120003999253;1658.0549087020524;1659.4772646616277;1660.9335626575044;1028.8199565076081;1086.5490821309227;1096.9633696157055;1116.8994790468896;1129.282905355089;6177.413145751147;6180.6600636965395;6184.907226391608;6193.473554747897;6200.193974783249;6559.180102487189;6562.573432726857;6570.5400621956005;6575.178102737158;6577.506686998494;6153.2000839891425;6159.045347971071;6164.537659675452;6164.907526387018;6172.629642221391;3502.824858757052;3535.8232088395475;3544.6455354464865;3547.467879817996;3552.1297282166033;6662.467002639777;6793.694283757242;6822.522423430411;6825.385715285648;6841.692123854438;6673.833154171185;6699.095622090956;6706.195256569243;6711.899321510181;6714.932850671431;6791.252962174157;6796.422304104108;6797.5581587196675;6802.455803535705;6802.727890884408;6531.542792004704;6535.215774107138;6544.44372228366;6556.63938483388;6559.508036897348;6313.779017734358;6438.484921206386;6440.32376600469;6451.741930322923;6456.5787829563915;6740.640775728456;6766.93233067663;6784.118064651564;6796.116504854337;6800.693968771516;4655.790489428052;4657.394538709946;4661.160991021648;4662.114198302312;4663.253879379283;6446.161998940108;6476.060971159061;6485.189351331083;6487.22153341602;6499.2200935887995;6242.812715618538;6309.652969086745;6357.427831495188;6361.681915904093;6362.109304697438;6330.240371155491;6361.14124593174;6363;6366.045093236052;6368.235811702625;6212.751489940351;6220.253569571681;6220.906686399798;6220.906686399798;6225.937740622536;6344.429001389897;6380.042993551005;6380.776672816429;6382.87234255303;6390.424861762278;6027.57806953509;6109.938900610937;6243.125962365181;6248.312685604671;6353.5870168438905 03:42:55 INFO - PROCESS | 30516 | |5;yui.html;879.5734068976548;897.3494216692899;917.3349321741742;917.6650522559264;925.5141050948251;13586.728265434685;13753.724925501483;13819.585412437618;13827.723445531095;13851.30743462828;13798.586042418743;13802.723945521084;13906.096103753274;13972.231527265996;13976.231307278122;775.3138472451865;901.7475106970043;921.2952091649893;921.5208091792298;922.0825278847523;915.1489115122934;946.4037656276536;950.3680052764903;950.6054987180346;951.4671783801059;976.2141476111727;980.9705708828747;983.0071627656083;986.57577241786;986.7927735175622;813.5566116466481;947.3984020147187;971.048372594854;972.5429048347265;972.5963725054094;719.8020544350345;720.3984672798167;721.700494294867;724.4530379563448;727.207343995048;14181.645458863508;14211.644708882257;14242.715145697131;14300.141991480441;14308.28458577067;13339.666508337272;13885.722285554333;14025.5091071812;14073.2963351832;14080.929595351958;11145.888541114566;11283.37941413222;11365.261258018203;11439;11457.427128643618;3832.770033797981;3930.8231129599235;3948.5853985331414;4039.333509970851;4042.939355909664;48100.75949620229;48820;49178.508214917754;49199.26201107022;50176;10696.51865666047;11182.776344473064;11286.717832054264;11316.94341528287;11511.827322590168;19217.61564768725;19228.134733937008;19255.711164332548;20580.485487862923;20751.273705420237;8190.099089100194;8319.8336033279;8390.454620449651;8462.02686691026;8514.74455766328;4607.285870690049;4644.140833945731;4720;4741.644376671763;4821.927671084936;3457.4640930655787;3499.9825000874835;3512.1395258161915;3519.1554027033326;3520.4543295789194;641.5252712992445;647.695583075963;652.0870780906769;666.8966310221923;674.922383925845;660.7621256347711;691.5919607431539;723.464636169231;732.3701616609711;737.5464089584867;8496.617652205665;8648.351373647001;8774.429662071945;8876.334274929277;9127.245531225657;608.5800797449746;620.2061361457341;624.2259598098416;674.0024763350269;700.9929900700928;3835.8657446989223;3935.6064393560987;4112.259793237246;4162.438070860456;4218.114196018871;56943.43056569464;58047.709761450926;58381;58664;58801;51268;52443.73778131085;52538;52622.736886315324;53310;45410.772946135716;45967.540324596994;45988;46316.3052554212;46690.5330946693;8161.183881611792;8214.794630134294;8219.876701849596;8400.201980811813;8425.199606037417;36316.636833631324;36592.63407365892;37257.25485490221;37441.81279093587;37999.810000949816;46009.76995115003;46759.53240467552;47095.764521177174;47775;47823.52176478191;11237.38194399316;11484.770304593694;11484.88515114838;11538.653840384803;11575.942120289345;12066.698332541757;12069.879301206876;12123.090768192596;12406.565770198;12559.120861539604;11599;12387.132900696864;12916.09587328878;13003.284819335027;13075.476980920657;12342.876571234532;12533.435995380047;12651.810222846849;12655.493780249055;12690.175138615961;11626.186166968231;11678.591249306233;12039.578614748792;12237.326947018;12273;10740.248182627454;10769.13846892231;11078.833817492583;11103.278286911325;11109.388983605979;10437.530311135864;10938;10977.615783447542;11083.501242443948;11135.220534562503 03:42:55 INFO - PROCESS | 30516 | __end_tp_report 03:42:55 INFO - PROCESS | 30516 | __start_cc_report 03:42:55 INFO - PROCESS | 30516 | _x_x_mozilla_cycle_collect,848 03:42:55 INFO - PROCESS | 30516 | __end_cc_report 03:42:55 INFO - PROCESS | 30516 | __startTimestamp1460889775776__endTimestamp 03:42:55 INFO - PROCESS | 30516 | 03:42:55 INFO - PROCESS | 30516 | ------- Summary: start ------- 03:42:55 INFO - PROCESS | 30516 | Number of tests: 6 03:42:55 INFO - PROCESS | 30516 | 03:42:55 INFO - PROCESS | 30516 | [#0] dojo.html Cycles:165 Average:5291.36 Median:5469.10 stddev:571.69 (10.5%) stddev-sans-first:549.94 03:42:55 INFO - PROCESS | 30516 | Values: 3223.1 3265.9 3283.3 3290.1 3323.3 5222.1 5230.3 5230.5 5252.7 5291.0 5216.4 5240.0 5241.5 5247.1 5278.9 4692.7 4824.3 4827.8 4865.0 4872.7 4821.8 4830.3 4863.4 4867.0 4867.3 4845.3 4856.6 4908.0 4913.3 4915.5 4926.6 4940.8 4946.4 4954.9 4965.5 4762.5 4805.5 4857.7 4883.9 4913.7 5092.3 5126.1 5141.3 5142.2 5160.7 5566.9 5567.6 5708.8 5729.5 5731.3 5685.8 5738.5 5747.6 5756.8 5771.3 5267.5 5285.7 5286.6 5288.1 5289.1 5738.8 5740.6 5741.1 5836.9 5923.4 5631.0 5652.2 5654.3 5656.0 5660.9 5718.1 5724.9 5736.6 5741.7 5746.8 5588.2 5681.6 5684.4 5764.8 5770.6 5667.0 5671.5 5679.0 5683.9 5685.7 4347.3 4393.1 4395.7 4399.3 4415.0 3869.5 3896.2 3929.0 3971.1 3977.9 5363.9 5397.3 5412.9 5419.1 5453.7 5533.9 5712.4 5717.2 5717.7 5718.6 5351.0 5385.1 5417.8 5418.9 5447.6 4904.7 4927.3 4928.8 4928.8 4958.1 5694.5 5793.4 5836.2 5837.0 5863.3 5689.4 5734.6 5753.2 5761.3 5793.9 5916.8 5935.6 5941.3 5944.5 5947.9 5409.8 5510.4 5543.6 5653.7 5662.0 5736.9 5739.3 5745.3 5751.1 5752.8 5564.0 5609.3 5610.1 5610.3 5613.6 5345.8 5518.0 5584.0 5592.6 5646.3 5445.4 5460.2 5469.1 5481.0 5482.5 5538.8 5569.1 5583.9 5588.8 5603.5 5295.3 5301.9 5417.5 5520.9 5536.9 03:42:55 INFO - PROCESS | 30516 | 03:42:55 INFO - PROCESS | 30516 | [#1] ext.html Cycles:180 Average:48422.87 Median:40411.30 stddev:79861.66 (197.6%) stddev-sans-first:80004.80 03:42:55 INFO - PROCESS | 30516 | Values: 550.2 576.9 579.7 590.8 595.4 30169.7 30614.8 30650.2 42645.8 44121.0 45994.3 46021.5 46578.8 46667.3 46803.0 9051.0 9230.2 9265.8 9271.5 9276.1 9118.4 9259.8 9261.4 9280.8 9306.0 9304.1 9414.0 9416.3 9416.6 9419.9 9230.6 9310.0 9314.1 9318.7 9319.8 9186.9 9335.4 9345.2 9346.6 9350.9 43983.6 44697.0 44737.8 44777.0 44877.3 3808.3 3829.6 3971.5 4221.3 4233.4 30761.5 30917.2 31277.8 31339.0 31864.2 4213.7 4294.3 4298.7 4404.2 4431.1 304510.0 309551.0 310134.0 310180.0 311303.0 47859.3 71746.6 73919.0 74183.0 74457.0 47519.3 47864.0 47866.8 47895.3 47962.3 17022.8 17256.7 17269.2 17293.2 17303.6 12749.7 12768.4 12806.9 12810.9 12812.7 15808.4 15854.7 15874.3 16515.1 16701.5 6280.4 6340.7 6383.4 6453.3 6460.3 1011.9 1062.8 1081.2 1083.0 1088.5 29447.0 29914.7 30531.5 31082.2 31332.0 1126.3 1182.4 1186.9 1235.2 1241.8 15707.9 15733.0 15817.1 15968.7 16203.8 358346.0 363082.0 363658.0 364539.0 364831.0 59134.4 59978.0 60041.4 60186.7 60271.0 1266.8 1406.4 1426.3 1491.2 1591.9 26863.6 27348.0 27377.0 27686.0 29889.7 47400.3 47463.8 47752.8 47772.8 47824.5 224785.0 227170.0 227945.0 228095.0 228229.0 30803.8 35158.3 35198.8 35232.3 35450.0 51804.0 52439.5 52513.5 53119.0 53135.7 40288.0 40550.0 40655.0 41508.8 41729.6 39259.0 39378.4 39689.6 39707.4 40534.6 40069.2 42487.2 43044.1 43178.4 43627.3 36006.0 36802.6 39836.4 39868.8 40587.4 27198.6 27743.9 27771.2 27823.0 27860.9 03:42:55 INFO - PROCESS | 30516 | 03:42:55 INFO - PROCESS | 30516 | [#2] jquery.html Cycles:180 Average:25756.48 Median:3005.52 stddev:71609.79 (2382.6%) stddev-sans-first:71785.33 03:42:55 INFO - PROCESS | 30516 | Values: 380.6 387.6 389.1 395.0 395.2 17433.5 17561.5 17948.0 17963.0 18028.4 17600.8 17921.6 18615.1 18615.7 18644.7 5633.2 5745.0 5758.2 5787.0 5788.7 5524.0 5626.2 5668.9 5702.3 5715.9 5609.5 5619.9 5653.0 5658.1 5667.1 5353.5 5483.2 5569.6 5570.8 5582.6 5268.2 5275.8 5312.0 5314.1 5316.0 13827.9 14319.0 21923.2 21924.6 22002.7 2262.7 2493.0 2711.5 2994.5 3016.5 10085.6 10232.8 10420.2 12428.5 13951.7 1723.4 1806.1 1824.2 1833.4 1915.8 60771.0 60807.7 60984.7 61456.7 61628.0 10249.5 10444.7 10543.2 10932.7 11030.2 14563.3 14676.3 14684.0 14684.6 14688.0 7798.0 8055.5 8109.2 8120.9 8194.3 7849.7 7852.8 7896.1 7921.3 7971.1 4712.6 4717.5 4729.7 4743.1 4758.3 1793.7 1899.0 1912.2 1938.0 1964.8 977.0 978.3 979.4 1015.9 1046.3 16483.6 16706.7 16914.9 17323.0 17462.6 972.9 973.7 980.2 993.4 1056.1 9693.2 10174.1 10180.1 10201.4 10462.7 427114.0 436106.0 436869.0 442565.0 443109.0 71370.0 74534.0 75402.2 75455.6 75477.6 1012.6 1023.9 1027.8 1033.4 1058.5 15611.2 15933.0 15953.2 16121.1 16149.4 34407.8 34940.3 35054.3 35781.5 35790.6 48436.5 50392.5 50459.5 50554.5 50655.2 8437.1 8486.4 8507.0 8678.6 8716.5 12424.1 13270.7 13386.6 13516.9 13570.2 11392.6 11426.3 11506.8 11745.5 11769.6 10964.3 10985.7 11126.2 11140.3 11231.3 11692.8 11849.9 11858.8 11996.6 12083.5 8383.5 8408.7 8499.8 8608.9 8687.4 11044.7 11330.7 11346.4 11399.5 11454.7 03:42:55 INFO - PROCESS | 30516 | 03:42:55 INFO - PROCESS | 30516 | [#3] mootools.html Cycles:180 Average:5876.30 Median:2796.91 stddev:3162.35 (113.1%) stddev-sans-first:3153.36 03:42:55 INFO - PROCESS | 30516 | Values: 1404.5 1571.9 1592.4 1764.7 1931.2 7581.5 8151.8 8316.1 8343.4 8344.5 8221.1 8409.6 8413.4 8428.7 8444.3 2096.5 2290.6 2346.4 2351.1 2385.0 2401.3 2407.2 2408.7 2410.7 2413.8 2306.9 2365.1 2365.7 2366.2 2370.0 2074.5 2261.7 2284.7 2290.7 2293.5 2264.6 2271.5 2280.8 2281.1 2339.2 8269.9 8322.4 8333.5 8349.8 8353.9 4751.6 4884.5 4888.5 4897.8 4961.0 3142.6 3178.9 3198.3 3215.1 3218.8 934.3 934.7 936.3 958.0 974.1 11725.1 11812.7 11821.3 11821.8 11833.4 4409.8 4473.6 4537.8 4560.8 4578.9 10042.1 10066.8 10067.0 10089.3 10102.9 4680.6 5083.3 5127.2 5135.1 5137.9 4530.9 4588.9 4593.7 4607.3 4607.8 3808.0 3818.5 3884.0 3893.8 3905.4 1179.0 1231.5 1235.6 1236.9 1244.8 1382.2 1489.3 1498.7 1507.7 1513.8 8106.7 8130.4 8164.9 8171.5 8185.5 483.0 499.6 501.2 505.5 510.5 6120.2 6156.9 6175.4 6230.7 6237.3 10035.5 10295.5 10396.5 10555.0 10590.5 10061.8 10353.7 10368.3 10372.9 10426.9 8064.1 8123.4 8143.5 8184.3 8209.6 7643.0 7801.5 7805.0 7806.3 7835.5 9064.1 9206.6 9220.7 9360.9 9385.1 9232.0 9433.9 9593.3 9600.0 9650.4 6729.3 6949.2 7092.6 7506.3 7619.6 8159.1 8160.7 8181.3 8197.7 8210.6 7131.9 7316.5 7362.8 7393.0 7469.5 7126.6 7214.8 7223.4 7294.2 7350.0 7689.4 7718.5 7761.5 7773.5 7774.2 6696.1 6838.9 6871.8 6880.6 6886.2 7083.5 7152.7 7158.6 7167.2 7175.8 03:42:55 INFO - PROCESS | 30516 | 03:42:55 INFO - PROCESS | 30516 | [#4] prototype.html Cycles:180 Average:5360.66 Median:6099.09 stddev:1578.99 (25.9%) stddev-sans-first:1537.94 03:42:55 INFO - PROCESS | 30516 | Values: 347.9 350.2 364.0 367.6 379.3 5936.5 5964.7 6038.5 6039.7 6088.2 5967.9 5977.0 5982.7 5983.7 6014.7 4507.5 4562.7 4643.5 4699.0 4702.2 4701.2 4722.2 4737.8 4738.7 4742.6 4696.8 4697.6 4701.8 4702.7 4702.8 4442.9 4551.4 4652.3 4672.8 4711.0 4193.9 4205.9 4206.0 4214.3 4214.8 5664.2 5672.8 5674.9 5679.5 5680.6 5476.2 5484.4 5487.7 5492.2 5511.5 6369.9 6376.3 6383.3 6384.2 6388.9 4360.6 4540.5 4543.3 4555.8 4681.1 6600.7 6661.6 6670.1 6674.5 6679.1 4658.7 4664.6 4666.3 4667.6 4672.4 4714.9 4718.8 4724.6 4734.2 4734.6 5406.9 5408.6 5410.4 5424.1 5427.1 6258.4 6384.7 6386.8 6406.8 6408.4 1619.9 1645.7 1658.1 1659.5 1660.9 1028.8 1086.5 1097.0 1116.9 1129.3 6177.4 6180.7 6184.9 6193.5 6200.2 6559.2 6562.6 6570.5 6575.2 6577.5 6153.2 6159.0 6164.5 6164.9 6172.6 3502.8 3535.8 3544.6 3547.5 3552.1 6662.5 6793.7 6822.5 6825.4 6841.7 6673.8 6699.1 6706.2 6711.9 6714.9 6791.3 6796.4 6797.6 6802.5 6802.7 6531.5 6535.2 6544.4 6556.6 6559.5 6313.8 6438.5 6440.3 6451.7 6456.6 6740.6 6766.9 6784.1 6796.1 6800.7 4655.8 4657.4 4661.2 4662.1 4663.3 6446.2 6476.1 6485.2 6487.2 6499.2 6242.8 6309.7 6357.4 6361.7 6362.1 6330.2 6361.1 6363.0 6366.0 6368.2 6212.8 6220.3 6220.9 6220.9 6225.9 6344.4 6380.0 6380.8 6382.9 6390.4 6027.6 6109.9 6243.1 6248.3 6353.6 03:42:55 INFO - PROCESS | 30516 | 03:42:55 INFO - PROCESS | 30516 | [#5] yui.html Cycles:180 Average:14441.73 Median:45689.16 stddev:16248.10 (35.6%) stddev-sans-first:16261.76 03:42:55 INFO - PROCESS | 30516 | Values: 879.6 897.3 917.3 917.7 925.5 13586.7 13753.7 13819.6 13827.7 13851.3 13798.6 13802.7 13906.1 13972.2 13976.2 775.3 901.7 921.3 921.5 922.1 915.1 946.4 950.4 950.6 951.5 976.2 981.0 983.0 986.6 986.8 813.6 947.4 971.0 972.5 972.6 719.8 720.4 721.7 724.5 727.2 14181.6 14211.6 14242.7 14300.1 14308.3 13339.7 13885.7 14025.5 14073.3 14080.9 11145.9 11283.4 11365.3 11439.0 11457.4 3832.8 3930.8 3948.6 4039.3 4042.9 48100.8 48820.0 49178.5 49199.3 50176.0 10696.5 11182.8 11286.7 11316.9 11511.8 19217.6 19228.1 19255.7 20580.5 20751.3 8190.1 8319.8 8390.5 8462.0 8514.7 4607.3 4644.1 4720.0 4741.6 4821.9 3457.5 3500.0 3512.1 3519.2 3520.5 641.5 647.7 652.1 666.9 674.9 660.8 691.6 723.5 732.4 737.5 8496.6 8648.4 8774.4 8876.3 9127.2 608.6 620.2 624.2 674.0 701.0 3835.9 3935.6 4112.3 4162.4 4218.1 56943.4 58047.7 58381.0 58664.0 58801.0 51268.0 52443.7 52538.0 52622.7 53310.0 45410.8 45967.5 45988.0 46316.3 46690.5 8161.2 8214.8 8219.9 8400.2 8425.2 36316.6 36592.6 37257.3 37441.8 37999.8 46009.8 46759.5 47095.8 47775.0 47823.5 11237.4 11484.8 11484.9 11538.7 11575.9 12066.7 12069.9 12123.1 12406.6 12559.1 11599.0 12387.1 12916.1 13003.3 13075.5 12342.9 12533.4 12651.8 12655.5 12690.2 11626.2 11678.6 12039.6 12237.3 12273.0 10740.2 10769.1 11078.8 11103.3 11109.4 10437.5 10938.0 10977.6 11083.5 11135.2 03:42:55 INFO - PROCESS | 30516 | -------- Summary: end -------- 03:42:55 INFO - PROCESS | 30516 | 03:42:56 INFO - TEST-INFO | 30516: exit 0 03:42:56 INFO - TEST-OK | dromaeo_css | took 1111471ms 03:42:56 INFO - TEST-START | kraken 03:42:56 INFO - operating with platform_type : linux_ 03:42:56 INFO - Initialising browser for kraken test... 03:42:56 INFO - TEST-INFO | started process 30708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPjqPcn/profile http://localhost:51384/getInfo.html) 03:43:00 INFO - PROCESS | 30708 | __metrics Screen width/height:1600/1200 03:43:00 INFO - PROCESS | 30708 | colorDepth:24 03:43:00 INFO - PROCESS | 30708 | Browser inner width/height: 1024/697 03:43:00 INFO - PROCESS | 30708 | __metrics 03:43:01 INFO - PROCESS | 30708 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:43:02 INFO - TEST-INFO | 30708: exit 0 03:43:02 INFO - Browser initialized. 03:43:02 INFO - Running cycle 1/1 for kraken test... 03:43:02 INFO - TEST-INFO | started process 30800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPjqPcn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:14 INFO - PROCESS | 30800 | RSS: Main: 142110720 03:43:14 INFO - PROCESS | 30800 | 03:43:16 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51384/tests/kraken/driver.html?testName=audio-beat-detection) 03:43:17 INFO - PROCESS | 30800 | RSS: Main: 178384896 03:43:17 INFO - PROCESS | 30800 | 03:43:20 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51384/tests/kraken/driver.html?testName=audio-dft) 03:43:20 INFO - PROCESS | 30800 | RSS: Main: 176070656 03:43:20 INFO - PROCESS | 30800 | 03:43:23 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51384/tests/kraken/driver.html?testName=audio-fft) 03:43:24 INFO - PROCESS | 30800 | RSS: Main: 173129728 03:43:24 INFO - PROCESS | 30800 | 03:43:26 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51384/tests/kraken/driver.html?testName=audio-oscillator) 03:43:26 INFO - PROCESS | 30800 | RSS: Main: 173064192 03:43:26 INFO - PROCESS | 30800 | 03:43:28 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51384/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:43:29 INFO - PROCESS | 30800 | RSS: Main: 171622400 03:43:29 INFO - PROCESS | 30800 | 03:43:32 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51384/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:33 INFO - PROCESS | 30800 | RSS: Main: 172072960 03:43:33 INFO - PROCESS | 30800 | 03:43:36 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51384/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:37 INFO - PROCESS | 30800 | RSS: Main: 172462080 03:43:37 INFO - PROCESS | 30800 | 03:43:39 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51384/tests/kraken/driver.html?testName=json-parse-financial) 03:43:40 INFO - PROCESS | 30800 | RSS: Main: 172609536 03:43:40 INFO - PROCESS | 30800 | 03:43:41 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51384/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:43:42 INFO - PROCESS | 30800 | RSS: Main: 178229248 03:43:42 INFO - PROCESS | 30800 | 03:43:44 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51384/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:43:44 INFO - PROCESS | 30800 | RSS: Main: 176611328 03:43:44 INFO - PROCESS | 30800 | 03:43:46 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51384/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:43:47 INFO - PROCESS | 30800 | RSS: Main: 182476800 03:43:47 INFO - PROCESS | 30800 | 03:43:49 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:50 INFO - PROCESS | 30800 | RSS: Main: 189554688 03:43:50 INFO - PROCESS | 30800 | 03:43:52 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:53 INFO - PROCESS | 30800 | RSS: Main: 189394944 03:43:53 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:51384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51384/tests/kraken/driver.html?testName=ai-astar) 03:43:55 INFO - PROCESS | 30800 | RSS: Main: 251547648 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | __start_tp_report 03:43:55 INFO - PROCESS | 30800 | _x_x_mozilla_page_load 03:43:55 INFO - PROCESS | 30800 | _x_x_mozilla_page_load_details 03:43:55 INFO - PROCESS | 30800 | |i|pagename|runs| 03:43:55 INFO - PROCESS | 30800 | |0;ai-astar;111;111;107;112;110;111;99;111;113;109 03:43:55 INFO - PROCESS | 30800 | |1;audio-beat-detection;152;130;160;170;133;157;156;131;170;128 03:43:55 INFO - PROCESS | 30800 | |2;audio-dft;163;163;164;162;163;164;161;165;164;163 03:43:55 INFO - PROCESS | 30800 | |3;audio-fft;77;75;77;164;75;75;78;76;161;77 03:43:55 INFO - PROCESS | 30800 | |4;audio-oscillator;93;94;136;93;94;94;154;93;94;140 03:43:55 INFO - PROCESS | 30800 | |5;imaging-gaussian-blur;118;118;118;117;117;117;116;117;117;116 03:43:55 INFO - PROCESS | 30800 | |6;imaging-darkroom;146;145;145;146;146;147;146;146;146;145 03:43:55 INFO - PROCESS | 30800 | |7;imaging-desaturate;96;96;95;96;95;95;95;95;95;96 03:43:55 INFO - PROCESS | 30800 | |8;json-parse-financial;53;57;55;56;55;56;58;65;55;54 03:43:55 INFO - PROCESS | 30800 | |9;json-stringify-tinderbox;66;66;66;66;67;67;66;65;66;67 03:43:55 INFO - PROCESS | 30800 | |10;stanford-crypto-aes;77;77;78;76;77;76;76;78;77;77 03:43:55 INFO - PROCESS | 30800 | |11;stanford-crypto-ccm;113;110;109;120;113;119;114;115;112;109 03:43:55 INFO - PROCESS | 30800 | |12;stanford-crypto-pbkdf2;137;130;137;138;136;127;137;134;149;137 03:43:55 INFO - PROCESS | 30800 | |13;stanford-crypto-sha256-iterative;68;69;66;66;65;67;64;65;67;64 03:43:55 INFO - PROCESS | 30800 | __end_tp_report 03:43:55 INFO - PROCESS | 30800 | __start_cc_report 03:43:55 INFO - PROCESS | 30800 | _x_x_mozilla_cycle_collect,1057 03:43:55 INFO - PROCESS | 30800 | __end_cc_report 03:43:55 INFO - PROCESS | 30800 | __startTimestamp1460889835317__endTimestamp 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | ------- Summary: start ------- 03:43:55 INFO - PROCESS | 30800 | Number of tests: 14 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:4.01 (3.6%) stddev-sans-first:4.21 03:43:55 INFO - PROCESS | 30800 | Values: 111.0 111.0 107.0 112.0 110.0 111.0 99.0 111.0 113.0 109.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:156.50 stddev:16.69 (10.7%) stddev-sans-first:17.66 03:43:55 INFO - PROCESS | 30800 | Values: 152.0 130.0 160.0 170.0 133.0 157.0 156.0 131.0 170.0 128.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.14 (0.7%) stddev-sans-first:1.20 03:43:55 INFO - PROCESS | 30800 | Values: 163.0 163.0 164.0 162.0 163.0 164.0 161.0 165.0 164.0 163.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.50 stddev:36.39 (47.6%) stddev-sans-first:38.10 03:43:55 INFO - PROCESS | 30800 | Values: 77.0 75.0 77.0 164.0 75.0 75.0 78.0 76.0 161.0 77.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.50 stddev:24.45 (26.2%) stddev-sans-first:25.28 03:43:55 INFO - PROCESS | 30800 | Values: 93.0 94.0 136.0 93.0 94.0 94.0 154.0 93.0 94.0 140.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 03:43:55 INFO - PROCESS | 30800 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:43:55 INFO - PROCESS | 30800 | Values: 146.0 145.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:43:55 INFO - PROCESS | 30800 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:3.34 (6.0%) stddev-sans-first:3.31 03:43:55 INFO - PROCESS | 30800 | Values: 53.0 57.0 55.0 56.0 55.0 56.0 58.0 65.0 55.0 54.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 03:43:55 INFO - PROCESS | 30800 | Values: 66.0 66.0 66.0 66.0 67.0 67.0 66.0 65.0 66.0 67.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 03:43:55 INFO - PROCESS | 30800 | Values: 77.0 77.0 78.0 76.0 77.0 76.0 76.0 78.0 77.0 77.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:113.50 stddev:3.81 (3.4%) stddev-sans-first:4.03 03:43:55 INFO - PROCESS | 30800 | Values: 113.0 110.0 109.0 120.0 113.0 119.0 114.0 115.0 112.0 109.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.20 Median:137.00 stddev:5.75 (4.2%) stddev-sans-first:6.09 03:43:55 INFO - PROCESS | 30800 | Values: 137.0 130.0 137.0 138.0 136.0 127.0 137.0 134.0 149.0 137.0 03:43:55 INFO - PROCESS | 30800 | 03:43:55 INFO - PROCESS | 30800 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.66 (2.5%) stddev-sans-first:1.62 03:43:55 INFO - PROCESS | 30800 | Values: 68.0 69.0 66.0 66.0 65.0 67.0 64.0 65.0 67.0 64.0 03:43:55 INFO - PROCESS | 30800 | -------- Summary: end -------- 03:43:55 INFO - PROCESS | 30800 | 03:43:56 INFO - TEST-INFO | 30800: exit 0 03:43:56 INFO - TEST-OK | kraken | took 60025ms 03:43:56 INFO - SUITE-END | took 1171s 03:43:56 INFO - Completed test suite (00:19:31) 03:43:56 INFO - javascript benchmark 03:43:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3223.113643747969, 3265.8856940007104, 3283.3269179818126, 3290.128116049246, 3323.3021065576227, 5222.138347172712, 5230.34620672416, 5230.476952304777, 5252.684838909663, 5291.0211610851975, 5216.426193118754, 5240.0, 5241.5020573045595, 5247.107991641421, 5278.947210527894, 4692.741899195543, 4824.276358546229, 4827.8310259140935, 4864.951350486485, 4872.683275587093, 4821.807127714887, 4830.275458681208, 4863.392075990501, 4867.0, 4867.2942423348595, 4845.3216549683075, 4856.6357523185725, 4907.975460122694, 4913.287573301869, 4915.483874193212, 4926.630502712275, 4940.752962351886, 4946.431160416562, 4954.87612809679, 4965.503449655042, 4762.547557981986, 4805.471398146201, 4857.684250523705, 4883.902321953577, 4913.729744864031, 5092.312537807423, 5126.077306084903, 5141.331626888518, 5142.1772516397195, 5160.690358578498, 5566.944330556724, 5567.554595632339, 5708.800191993302, 5729.541636669056, 5731.254936858223, 5685.800996965087, 5738.454846789548, 5747.626404283708, 5756.7985120521, 5771.336296325934, 5267.499587539178, 5285.68285902847, 5286.60350473716, 5288.0745869472685, 5289.100852855024, 5738.8278351649515, 5740.6268592541355, 5741.1388291756575, 5836.88326233473, 5923.378045305181, 5631.0, 5652.152177173375, 5654.321481422174, 5656.0, 5660.8867822643315, 5718.056520674042, 5724.856878577985, 5736.569757268138, 5741.741621627037, 5746.827595172068, 5588.217649528988, 5681.630694004876, 5684.37471878093, 5764.798232061941, 5770.567207459458, 5666.9716651416475, 5671.546276297886, 5679.0, 5683.943160568341, 5685.658860468385, 4347.34789781529, 4393.077453734688, 4395.736255824597, 4399.340098985178, 4414.977925110354, 3869.5356557213313, 3896.1818018215927, 3928.980355098206, 3971.0667993021616, 3977.940330895039, 5363.946360536423, 5397.298351214317, 5412.91880621791, 5419.105847535191, 5453.700046497402, 5533.916991245134, 5712.400197979236, 5717.199592057115, 5717.656940583495, 5718.599698021098, 5350.9732451337495, 5385.111456609616, 5417.783288668409, 5418.945810541923, 5447.591430642638, 4904.705717656952, 4927.260910863399, 4928.827491037797, 4928.827491037868, 4958.132326842788, 5694.4590263924865, 5793.449622285876, 5836.2412886325355, 5837.0, 5863.296404431496, 5689.374168841507, 5734.598578099493, 5753.165790960371, 5761.337446193574, 5793.884122317446, 5916.763329466773, 5935.584509084322, 5941.31674857397, 5944.494717949023, 5947.940520594739, 5409.78360865561, 5510.366307874646, 5543.6396634218645, 5653.717314134359, 5662.0, 5736.856578585569, 5739.311282645942, 5745.339285982165, 5751.079827227623, 5752.798652047159, 5563.972180139073, 5609.27079479665, 5610.074337734228, 5610.270664813548, 5613.607047506635, 5345.78616855337, 5517.972410137923, 5583.972080139573, 5592.5525957922455, 5646.322441306905, 5445.428230035947, 5460.180972853945, 5469.097598896137, 5480.972595136999, 5482.506574408322, 5538.778448862, 5569.10894256917, 5583.860403489945, 5588.804391846266, 5603.467670571289, 5295.258663786996, 5301.920471193012, 5417.539509141609, 5520.861978450571, 5536.889262214814], "unit": "score", "name": "dojo.html", "value": 5255.659147831894}, {"lowerIsBetter": false, "replicates": [550.1939658400443, 576.9163471296665, 579.6840721806615, 590.8316129902978, 595.3689089565061, 30169.69830301699, 30614.846925765367, 30650.23374415641, 42645.7867710661, 44121.0, 45994.31008534875, 46021.539784602144, 46578.76710616442, 46667.29999050008, 46803.0, 9050.954745226281, 9230.16928476437, 9265.768355791126, 9271.536423178848, 9276.11876871696, 9118.361714679975, 9259.814803703923, 9261.398009129418, 9280.7679808005, 9306.0, 9304.11610896967, 9413.952930235373, 9416.340856140074, 9416.62333506659, 9419.905800941971, 9230.630774769, 9310.0, 9314.115159059878, 9318.673846415342, 9319.813603727955, 9186.908130918739, 9335.439873607538, 9345.205657519118, 9346.626134954593, 9350.859737103881, 43983.56016439859, 44697.0, 44737.77631111856, 44777.0, 44877.32684009743, 3808.276427478798, 3829.63618456249, 3971.5035620547433, 4221.303484924983, 4233.428487154226, 30761.538576921364, 30917.22706932322, 31277.843610782027, 31339.0, 31864.203394915312, 4213.705040647156, 4294.26997410441, 4298.677599180074, 4404.163208990313, 4431.135928493945, 304510.0, 309551.0, 310134.0, 310180.0, 311303.0, 47859.28211076836, 71746.64126679333, 73919.0, 74183.0, 74457.0, 47519.287210691866, 47864.04271914542, 47866.760666196446, 47895.28157077647, 47962.28056579154, 17022.82977170237, 17256.65486690259, 17269.222884970208, 17293.221805018806, 17303.56741081483, 12749.68125796844, 12768.361581921052, 12806.935965320301, 12810.9359453204, 12812.743745125046, 15808.367665293259, 15854.682906341808, 15874.285657145456, 16515.091669958267, 16701.49895503137, 6280.434760871543, 6340.651264180422, 6383.425491705769, 6453.290138084807, 6460.289368169498, 1011.9241056920613, 1062.7661914378825, 1081.2053140941402, 1083.0019460191318, 1088.548252475214, 29447.0, 29914.70085299119, 30531.542026869614, 31082.22294442657, 31332.0, 1126.3298337489182, 1182.4400173624178, 1186.928784272929, 1235.215638069832, 1241.8385609870659, 15707.921460392625, 15733.0, 15817.089227905863, 15968.680626387408, 16203.756943645854, 358346.0, 363082.0, 363658.0, 364539.0, 364831.0, 59134.40865591375, 59978.0, 60041.39958600358, 60186.699066504385, 60271.0, 1266.7656483550388, 1406.3811922753955, 1426.3367534096694, 1491.246920305239, 1591.856732894045, 26863.597046043935, 27347.969768672818, 27377.0, 27686.0, 29889.701102988693, 47400.28899566578, 47463.762681186374, 47752.7612361936, 47772.761136194094, 47824.52175478201, 224785.0, 227170.0, 227945.0, 228095.0, 228229.0, 30803.84598076995, 35158.29683406369, 35198.824005879804, 35232.29535409329, 35450.0, 51804.0, 52439.47560524346, 52513.474865252385, 53119.0, 53135.73432132815, 40288.0, 40550.0, 40655.0, 41508.792456037525, 41729.58270417257, 39259.0, 39378.40932386074, 39689.60310396975, 39707.40438893361, 40534.594654054265, 40069.1986160281, 42487.15025699531, 43044.13911721685, 43178.35232471453, 43627.345589815544, 36006.0, 36802.63197367992, 39836.40245396379, 39868.800655996536, 40587.391189131595, 27198.592021119304, 27743.861280694277, 27771.166864994084, 27823.0, 27860.860695696392], "unit": "score", "name": "ext.html", "value": 19520.631567429336}, {"lowerIsBetter": false, "replicates": [380.6449041412571, 387.6143237478709, 389.09535330356914, 395.0439935356437, 395.1839451532585, 17433.476995690133, 17561.473155805314, 17948.0, 17963.012034338124, 18028.369007084755, 17600.82399176011, 17921.641567168648, 18615.069246537685, 18615.720764188514, 18644.720329195072, 5633.183188437664, 5745.023346031185, 5758.165066065418, 5787.0, 5788.6816225107605, 5524.0, 5626.184203290521, 5668.914966275509, 5702.258706368187, 5715.885682286352, 5609.467100625455, 5619.859503512424, 5653.0, 5658.122990936411, 5667.0932650775885, 5353.464653534655, 5483.150111732688, 5569.610127291091, 5570.805021824237, 5582.581306402016, 5268.1834315681135, 5275.788968441258, 5311.973440132813, 5314.123169676998, 5316.0, 13827.861721382758, 14319.0, 21923.232686855885, 21924.561508769893, 22002.669959950614, 2262.7171603549555, 2493.0, 2711.4983728010184, 2994.5208766597457, 3016.5173572228337, 10085.596576136946, 10232.795344093076, 10420.218483613759, 12428.502859885593, 13951.720965580631, 1723.4054251283287, 1806.060848358846, 1824.1973531646033, 1833.367488216563, 1915.82757551821, 60771.0, 60807.695961520796, 60984.69507652433, 61456.692716536134, 61628.0, 10249.487525623688, 10444.68665940023, 10543.156547476183, 10932.704132132183, 11030.22788404804, 14563.271836408137, 14676.266186690622, 14684.0, 14684.632884177981, 14688.045277056957, 7798.0, 8055.516668999879, 8109.189081091961, 8120.878186827203, 8194.344452443791, 7849.686012559548, 7852.764417067498, 7896.131425543185, 7921.32668723165, 7971.123176450586, 4712.64655150865, 4717.481077081518, 4729.668923175344, 4743.146233677902, 4758.262469317261, 1793.7219730941563, 1898.9715154272697, 1912.2064343297375, 1937.9515512112027, 1964.79369666183, 976.9511524423892, 978.280963491833, 979.4466126638426, 1015.8933312002133, 1046.2519298701466, 16483.58791030234, 16706.749398759028, 16914.915425422794, 17323.0, 17462.56343591395, 972.9416235025922, 973.7176218896583, 980.1717548671361, 993.4486360070086, 1056.0653821368144, 9693.185445260156, 10174.135198508062, 10180.134688551409, 10201.438920859424, 10462.68611941643, 427114.0, 436106.0, 436869.0, 442565.0, 443109.0, 71370.0, 74534.0, 75402.24597753953, 75455.62272188604, 75477.62261188768, 1012.6405126180247, 1023.8668973033458, 1027.7636143686993, 1033.4316126130598, 1058.5077938758513, 15611.219439027776, 15933.0, 15953.202339882728, 16121.113338766481, 16149.434769783002, 34407.827960860035, 34940.301193976484, 35054.29891402209, 35781.46327805033, 35790.64209357873, 48436.5156348432, 50392.49607503878, 50459.495405045476, 50554.49445505645, 50655.24017139672, 8437.071922088688, 8486.448380855225, 8506.957465212634, 8678.609462574326, 8716.477011379338, 12424.130310878152, 13270.668233294246, 13386.598402047954, 13516.93241533786, 13570.185788852701, 11392.601258955896, 11426.314421134759, 11506.82739758921, 11745.530178793095, 11769.646910592695, 10964.28732132409, 10985.670429887115, 11126.221164518405, 11140.33158010522, 11231.326120432801, 11692.824607631062, 11849.940750296193, 11858.822117668069, 11996.58011969577, 12083.516659333529, 8383.496990180609, 8408.705695300636, 8499.787505312417, 8608.913910861062, 8687.39188256816, 11044.723881903017, 11330.716732081764, 11346.432678366215, 11399.487023084146, 11454.656360309204], "unit": "score", "name": "jquery.html", "value": 8812.382753255237}, {"lowerIsBetter": false, "replicates": [1404.452263617189, 1571.9371225150994, 1592.3869310315529, 1764.7000009998299, 1931.2275089964003, 7581.545107293567, 8151.755447336582, 8316.085230624627, 8343.415960882732, 8344.541050242235, 8221.136780638037, 8409.57952102394, 8413.36899732521, 8428.747137585868, 8444.282236009947, 2096.4654013226605, 2290.610596198642, 2346.4133966508375, 2351.1300818697105, 2384.9642255366184, 2401.3396316013063, 2407.2296865003204, 2408.7470815564375, 2410.734819169899, 2413.79482743967, 2306.9307920762403, 2365.124903785602, 2365.6924599802087, 2366.2428023032635, 2370.0401337458356, 2074.471009892475, 2261.6720575516542, 2284.725832900046, 2290.7136607924094, 2293.5298263856034, 2264.62633665445, 2271.454850835804, 2280.783325584067, 2281.0989659084566, 2339.169594793858, 8269.917300826975, 8322.375821813388, 8333.541655208961, 8349.8330033399, 8353.916460835375, 4751.572358487718, 4884.487128851455, 4888.5111488850835, 4897.804087836482, 4961.032598643266, 3142.607174103237, 3178.9364212715845, 3198.2643991881996, 3215.099772063826, 3218.8229647369385, 934.2619330728717, 934.700895713372, 936.3445588088298, 958.0132463562542, 974.0600320690568, 11725.061995040376, 11812.70468238301, 11821.290722556589, 11821.763564728742, 11833.408329583486, 4409.779511024436, 4473.597376236155, 4537.795799189044, 4560.771961401917, 4578.885527861764, 10042.146417554444, 10066.848997265048, 10067.043630855058, 10089.293749437616, 10102.949485252526, 4680.648951328664, 5083.288339632454, 5127.154019586801, 5135.12702840518, 5137.948620513822, 4530.909381812346, 4588.88527786808, 4593.678442509059, 4607.262837945913, 4607.815687372467, 3808.0, 3818.503594532693, 3884.0484081400236, 3893.766374017568, 3905.3946638271113, 1178.9705257368462, 1231.4889320931893, 1235.604606525921, 1236.9319687417278, 1244.7883859743683, 1382.198324971514, 1489.3074720255133, 1498.707751988352, 1507.70599733051, 1513.8486151384773, 8106.716264930699, 8130.430869839054, 8164.918350816416, 8171.509709417454, 8185.467944583583, 483.04116329086736, 499.62278479748284, 501.22560643805406, 505.4642079395852, 510.5405135378189, 6120.234970628671, 6156.938430615636, 6175.3515880832765, 6230.719617617218, 6237.313895471494, 10035.548400322003, 10295.53670084833, 10396.48017599117, 10555.0, 10590.523426445829, 10061.849072263922, 10353.689389318333, 10368.326058806153, 10372.896271037192, 10426.947865260625, 8064.112947575762, 8123.390745694097, 8143.51138931666, 8184.304334131546, 8209.58952052395, 7643.0, 7801.45389822707, 7804.9609751950875, 7806.336461400618, 7835.451518393886, 9064.093590640883, 9206.631734730803, 9220.677276295297, 9360.859587106062, 9385.108414700593, 9232.03063678331, 9433.905660943577, 9593.328467007243, 9600.0, 9650.372725772802, 6729.327067293231, 6949.200841903245, 7092.574445533284, 7506.28690274423, 7619.619019048914, 8159.143289954469, 8160.714374996846, 8181.3045891097545, 8197.71308004241, 8210.58947052633, 7131.928680713334, 7316.451266154953, 7362.77911662651, 7392.96303518479, 7469.514481558681, 7126.608036557832, 7214.783556493314, 7223.386012189023, 7294.197638259681, 7350.044494215717, 7689.423293252917, 7718.498297610638, 7761.495502792526, 7773.533587984739, 7774.18371071052, 6696.062551242732, 6838.93161068383, 6871.793846184622, 6880.552764070319, 6886.24251332343, 7083.468739844429, 7152.713891444284, 7158.606276654834, 7167.247439019036, 7175.820604484929], "unit": "score", "name": "mootools.html", "value": 4687.403876669088}, {"lowerIsBetter": false, "replicates": [347.8938923628293, 350.1613635343352, 363.9727020473465, 367.6342039670528, 379.34752226170974, 5936.5250779937605, 5964.701764911753, 6038.5471089668345, 6039.698015099244, 6088.238970128734, 5967.850803729909, 5977.043673012319, 5982.730777115029, 5983.730732117055, 6014.669193194372, 4507.504174540798, 4562.726236425809, 4643.466001409847, 4699.036697477026, 4702.200625893606, 4701.177293973541, 4722.220833562458, 4737.834175803848, 4738.69198502098, 4742.620590352763, 4696.835610753625, 4697.600703940169, 4701.835435759749, 4702.670813043088, 4702.764861756916, 4442.911141777163, 4551.385562948993, 4652.325412815123, 4672.766361681936, 4711.0, 4193.874183774492, 4205.936910946339, 4205.957940420587, 4214.262504061777, 4214.7681877496725, 5664.178694089334, 5672.829815105553, 5674.858128546778, 5679.460451257124, 5680.602357834953, 5476.205950137248, 5484.369297530795, 5487.670739755627, 5492.176173573956, 5511.5039646432015, 6369.93630063698, 6376.330485299023, 6383.2978372379, 6384.170057892445, 6388.936110638927, 4360.6293465055505, 4540.477845047829, 4543.295789152687, 4555.840545580922, 4681.063787242531, 6600.702968366435, 6661.566998145105, 6670.09953656255, 6674.49941254403, 6679.064930909628, 4658.67227840064, 4664.626829853603, 4666.32338310943, 4667.649926255544, 4672.392588963413, 4714.929276060861, 4718.787654555554, 4724.6456515760765, 4734.21885388907, 4734.573888350065, 5406.91889621656, 5408.621396502286, 5410.377806552218, 5424.077906755861, 5427.050266203399, 6258.43674069336, 6384.744610215632, 6386.840328991812, 6406.839829004312, 6408.359164083555, 1619.9433019844485, 1645.7120003999253, 1658.0549087020524, 1659.4772646616277, 1660.9335626575044, 1028.8199565076081, 1086.5490821309227, 1096.9633696157055, 1116.8994790468896, 1129.282905355089, 6177.413145751147, 6180.6600636965395, 6184.907226391608, 6193.473554747897, 6200.193974783249, 6559.180102487189, 6562.573432726857, 6570.5400621956005, 6575.178102737158, 6577.506686998494, 6153.2000839891425, 6159.045347971071, 6164.537659675452, 6164.907526387018, 6172.629642221391, 3502.824858757052, 3535.8232088395475, 3544.6455354464865, 3547.467879817996, 3552.1297282166033, 6662.467002639777, 6793.694283757242, 6822.522423430411, 6825.385715285648, 6841.692123854438, 6673.833154171185, 6699.095622090956, 6706.195256569243, 6711.899321510181, 6714.932850671431, 6791.252962174157, 6796.422304104108, 6797.5581587196675, 6802.455803535705, 6802.727890884408, 6531.542792004704, 6535.215774107138, 6544.44372228366, 6556.63938483388, 6559.508036897348, 6313.779017734358, 6438.484921206386, 6440.32376600469, 6451.741930322923, 6456.5787829563915, 6740.640775728456, 6766.93233067663, 6784.118064651564, 6796.116504854337, 6800.693968771516, 4655.790489428052, 4657.394538709946, 4661.160991021648, 4662.114198302312, 4663.253879379283, 6446.161998940108, 6476.060971159061, 6485.189351331083, 6487.22153341602, 6499.2200935887995, 6242.812715618538, 6309.652969086745, 6357.427831495188, 6361.681915904093, 6362.109304697438, 6330.240371155491, 6361.14124593174, 6363.0, 6366.045093236052, 6368.235811702625, 6212.751489940351, 6220.253569571681, 6220.906686399798, 6220.906686399798, 6225.937740622536, 6344.429001389897, 6380.042993551005, 6380.776672816429, 6382.87234255303, 6390.424861762278, 6027.57806953509, 6109.938900610937, 6243.125962365181, 6248.312685604671, 6353.5870168438905], "unit": "score", "name": "prototype.html", "value": 4853.137882645704}, {"lowerIsBetter": false, "replicates": [879.5734068976548, 897.3494216692899, 917.3349321741742, 917.6650522559264, 925.5141050948251, 13586.728265434685, 13753.724925501483, 13819.585412437618, 13827.723445531095, 13851.30743462828, 13798.586042418743, 13802.723945521084, 13906.096103753274, 13972.231527265996, 13976.231307278122, 775.3138472451865, 901.7475106970043, 921.2952091649893, 921.5208091792298, 922.0825278847523, 915.1489115122934, 946.4037656276536, 950.3680052764903, 950.6054987180346, 951.4671783801059, 976.2141476111727, 980.9705708828747, 983.0071627656083, 986.57577241786, 986.7927735175622, 813.5566116466481, 947.3984020147187, 971.048372594854, 972.5429048347265, 972.5963725054094, 719.8020544350345, 720.3984672798167, 721.700494294867, 724.4530379563448, 727.207343995048, 14181.645458863508, 14211.644708882257, 14242.715145697131, 14300.141991480441, 14308.28458577067, 13339.666508337272, 13885.722285554333, 14025.5091071812, 14073.2963351832, 14080.929595351958, 11145.888541114566, 11283.37941413222, 11365.261258018203, 11439.0, 11457.427128643618, 3832.770033797981, 3930.8231129599235, 3948.5853985331414, 4039.333509970851, 4042.939355909664, 48100.75949620229, 48820.0, 49178.508214917754, 49199.26201107022, 50176.0, 10696.51865666047, 11182.776344473064, 11286.717832054264, 11316.94341528287, 11511.827322590168, 19217.61564768725, 19228.134733937008, 19255.711164332548, 20580.485487862923, 20751.273705420237, 8190.099089100194, 8319.8336033279, 8390.454620449651, 8462.02686691026, 8514.74455766328, 4607.285870690049, 4644.140833945731, 4720.0, 4741.644376671763, 4821.927671084936, 3457.4640930655787, 3499.9825000874835, 3512.1395258161915, 3519.1554027033326, 3520.4543295789194, 641.5252712992445, 647.695583075963, 652.0870780906769, 666.8966310221923, 674.922383925845, 660.7621256347711, 691.5919607431539, 723.464636169231, 732.3701616609711, 737.5464089584867, 8496.617652205665, 8648.351373647001, 8774.429662071945, 8876.334274929277, 9127.245531225657, 608.5800797449746, 620.2061361457341, 624.2259598098416, 674.0024763350269, 700.9929900700928, 3835.8657446989223, 3935.6064393560987, 4112.259793237246, 4162.438070860456, 4218.114196018871, 56943.43056569464, 58047.709761450926, 58381.0, 58664.0, 58801.0, 51268.0, 52443.73778131085, 52538.0, 52622.736886315324, 53310.0, 45410.772946135716, 45967.540324596994, 45988.0, 46316.3052554212, 46690.5330946693, 8161.183881611792, 8214.794630134294, 8219.876701849596, 8400.201980811813, 8425.199606037417, 36316.636833631324, 36592.63407365892, 37257.25485490221, 37441.81279093587, 37999.810000949816, 46009.76995115003, 46759.53240467552, 47095.764521177174, 47775.0, 47823.52176478191, 11237.38194399316, 11484.770304593694, 11484.88515114838, 11538.653840384803, 11575.942120289345, 12066.698332541757, 12069.879301206876, 12123.090768192596, 12406.565770198, 12559.120861539604, 11599.0, 12387.132900696864, 12916.09587328878, 13003.284819335027, 13075.476980920657, 12342.876571234532, 12533.435995380047, 12651.810222846849, 12655.493780249055, 12690.175138615961, 11626.186166968231, 11678.591249306233, 12039.578614748792, 12237.326947018, 12273.0, 10740.248182627454, 10769.13846892231, 11078.833817492583, 11103.278286911325, 11109.388983605979, 10437.530311135864, 10938.0, 10977.615783447542, 11083.501242443948, 11135.220534562503], "unit": "score", "name": "yui.html", "value": 6793.369194361684}], "name": "dromaeo_css", "value": 7203.587793280792}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 107.0, 112.0, 110.0, 111.0, 99.0, 111.0, 113.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [152.0, 130.0, 160.0, 170.0, 133.0, 157.0, 156.0, 131.0, 170.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 164.0, 162.0, 163.0, 164.0, 161.0, 165.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 77.0, 164.0, 75.0, 75.0, 78.0, 76.0, 161.0, 77.0], "unit": "score", "name": "audio-fft", "value": 93.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 136.0, 93.0, 94.0, 94.0, 154.0, 93.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [53.0, 57.0, 55.0, 56.0, 55.0, 56.0, 58.0, 65.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 65.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.2}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 78.0, 76.0, 77.0, 76.0, 76.0, 78.0, 77.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 76.9}, {"lowerIsBetter": true, "replicates": [113.0, 110.0, 109.0, 120.0, 113.0, 119.0, 114.0, 115.0, 112.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.4}, {"lowerIsBetter": true, "replicates": [137.0, 130.0, 137.0, 138.0, 136.0, 127.0, 137.0, 134.0, 149.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 66.0, 66.0, 65.0, 67.0, 64.0, 65.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1496.8000000000002}]} 03:43:57 INFO - Return code: 0 03:43:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:43:57 INFO - # TBPL SUCCESS # 03:43:57 INFO - Running post-action listener: _resource_record_post_action 03:43:57 INFO - Running post-run listener: _resource_record_post_run 03:43:58 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 497655808; Read time: 0; Write time: 514504 03:43:58 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 245121024; Read time: 0; Write time: 292952 03:43:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 252534784; Read time: 0; Write time: 221552 03:43:58 INFO - Running post-run listener: _upload_blobber_files 03:43:58 INFO - Blob upload gear active. 03:43:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:43:58 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:43:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:43:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:59 INFO - (blobuploader) - INFO - Done attempting. 03:43:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:43:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:44:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:00 INFO - (blobuploader) - INFO - Done attempting. 03:44:00 INFO - (blobuploader) - INFO - Iteration through files over. 03:44:00 INFO - Return code: 0 03:44:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:44:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:44:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7816b727d9d280b4a47cdae80c400f023952e149fb36576c788add2a595f9e536370ab985b1ec83ab1c6928b34d5d7dc596c04dd652549e9e3a23a133e5ed4a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3542c84a734eabd6d2e61661640bf32ae7eaaf8457f4fdb70fd877493f36112a72421eb3b6e49af81c6066ac4e7d0e0736af45eb7643f65bcac0716af4f9715f"} 03:44:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:44:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:44:00 INFO - Contents: 03:44:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7816b727d9d280b4a47cdae80c400f023952e149fb36576c788add2a595f9e536370ab985b1ec83ab1c6928b34d5d7dc596c04dd652549e9e3a23a133e5ed4a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3542c84a734eabd6d2e61661640bf32ae7eaaf8457f4fdb70fd877493f36112a72421eb3b6e49af81c6066ac4e7d0e0736af45eb7643f65bcac0716af4f9715f"} 03:44:00 INFO - Running post-run listener: copy_logs_to_upload_dir 03:44:00 INFO - Copying logs to upload dir... 03:44:00 INFO - mkdir: /builds/slave/test/build/upload/logs 03:44:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.241699 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-17 03:43:58.452055) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 03:43:58.455470) ========= 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=836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128 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/7816b727d9d280b4a47cdae80c400f023952e149fb36576c788add2a595f9e536370ab985b1ec83ab1c6928b34d5d7dc596c04dd652549e9e3a23a133e5ed4a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3542c84a734eabd6d2e61661640bf32ae7eaaf8457f4fdb70fd877493f36112a72421eb3b6e49af81c6066ac4e7d0e0736af45eb7643f65bcac0716af4f9715f"} build_url:https://queue.taskcluster.net/v1/task/Fdtd7H8eT0aALYEJWlWKsA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/Fdtd7H8eT0aALYEJWlWKsA/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/7816b727d9d280b4a47cdae80c400f023952e149fb36576c788add2a595f9e536370ab985b1ec83ab1c6928b34d5d7dc596c04dd652549e9e3a23a133e5ed4a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3542c84a734eabd6d2e61661640bf32ae7eaaf8457f4fdb70fd877493f36112a72421eb3b6e49af81c6066ac4e7d0e0736af45eb7643f65bcac0716af4f9715f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 03:43:58.483027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 03:43:58.483451) ========= 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=836cfdc75598d54cb747368e000001a9-1460884931.368392-1278088128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 03:43:58.571090) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 03:43:58.571451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 03:43:58.571798) ========= ========= Total master_lag: 0.20 =========