builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1461756673.65 results: success (0) buildid: 20160427025603 builduid: 3a5b84d2cfaf4104a9d688815a3e42b2 revision: 488df90abd620538454e58ae0a75f13453f391b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:13.652722) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:13.653214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:13.653501) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:13.670606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:13.671005) ========= 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=7de08804244eb36560b44971000001c3-1461756673.468384-2022228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 04:31:14-- 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% 42.9M=0s 2016-04-27 04:31:14 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072406 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:13.758808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:13.759160) ========= 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=7de08804244eb36560b44971000001c3-1461756673.468384-2022228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015117 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:13.808469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:13.811966) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 488df90abd620538454e58ae0a75f13453f391b1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 488df90abd620538454e58ae0a75f13453f391b1 --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=7de08804244eb36560b44971000001c3-1461756673.468384-2022228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 04:31:14,552 truncating revision to first 12 chars 2016-04-27 04:31:14,552 Setting DEBUG logging. 2016-04-27 04:31:14,552 attempt 1/10 2016-04-27 04:31:14,552 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/488df90abd62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 04:31:15,024 unpacking tar archive at: mozilla-central-488df90abd62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.745410 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:14.574728) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:14.575068) ========= script_repo_revision: 488df90abd620538454e58ae0a75f13453f391b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:14.575471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:14.575761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 04:31:14.586030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-27 04:31:14.586426) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=7de08804244eb36560b44971000001c3-1461756673.468384-2022228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:31:15 INFO - MultiFileLogger online at 20160427 04:31:15 in /builds/slave/test 04:31:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:31:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:15 INFO - {'append_to_log': False, 04:31:15 INFO - 'base_work_dir': '/builds/slave/test', 04:31:15 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:31:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:15 INFO - 'branch': 'Firefox-Non-PGO', 04:31:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:15 INFO - 'config_files': ('talos/linux_config.py',), 04:31:15 INFO - 'default_actions': ('clobber', 04:31:15 INFO - 'read-buildbot-config', 04:31:15 INFO - 'download-and-extract', 04:31:15 INFO - 'populate-webroot', 04:31:15 INFO - 'create-virtualenv', 04:31:15 INFO - 'install', 04:31:15 INFO - 'run-tests'), 04:31:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:15 INFO - 'download_minidump_stackwalk': True, 04:31:15 INFO - 'download_symbols': 'ondemand', 04:31:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:15 INFO - 'installer_path': 'installer.exe', 04:31:15 INFO - 'log_level': 'info', 04:31:15 INFO - 'log_name': 'talos', 04:31:15 INFO - 'log_to_console': True, 04:31:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:31:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:31:15 INFO - 'opt_config_files': (), 04:31:15 INFO - 'pip_index': False, 04:31:15 INFO - 'sps_profile': False, 04:31:15 INFO - 'sps_profile_interval': 0, 04:31:15 INFO - 'suite': 'dromaeojs', 04:31:15 INFO - 'system_bits': '32', 04:31:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:15 INFO - 'title': 'talos-linux64-ix-003', 04:31:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:15 INFO - 'use_talos_json': True, 04:31:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:15 INFO - 'work_dir': 'build'} 04:31:15 INFO - ##### 04:31:15 INFO - ##### Running clobber step. 04:31:15 INFO - ##### 04:31:15 INFO - Running pre-action listener: _resource_record_pre_action 04:31:15 INFO - Running main action method: clobber 04:31:15 INFO - rmtree: /builds/slave/test/build 04:31:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:15 INFO - Running post-action listener: _resource_record_post_action 04:31:15 INFO - ##### 04:31:15 INFO - ##### Running read-buildbot-config step. 04:31:15 INFO - ##### 04:31:15 INFO - Running pre-action listener: _resource_record_pre_action 04:31:15 INFO - Running main action method: read_buildbot_config 04:31:15 INFO - Using buildbot properties: 04:31:15 INFO - { 04:31:15 INFO - "project": "", 04:31:15 INFO - "product": "firefox", 04:31:15 INFO - "script_repo_revision": "production", 04:31:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:31:15 INFO - "repository": "", 04:31:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:31:15 INFO - "buildid": "20160427025603", 04:31:15 INFO - "pgo_build": "False", 04:31:15 INFO - "basedir": "/builds/slave/test", 04:31:15 INFO - "buildnumber": 78, 04:31:15 INFO - "slavename": "talos-linux64-ix-003", 04:31:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:31:15 INFO - "platform": "ubuntu64_hw", 04:31:15 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:31:15 INFO - "branch": "mozilla-central", 04:31:15 INFO - "repo_path": "mozilla-central", 04:31:15 INFO - "revision": "488df90abd620538454e58ae0a75f13453f391b1", 04:31:15 INFO - "stage_platform": "linux64", 04:31:15 INFO - "builduid": "3a5b84d2cfaf4104a9d688815a3e42b2", 04:31:15 INFO - "slavebuilddir": "test" 04:31:15 INFO - } 04:31:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:31:15 INFO - Running post-action listener: _resource_record_post_action 04:31:15 INFO - ##### 04:31:15 INFO - ##### Running download-and-extract step. 04:31:15 INFO - ##### 04:31:15 INFO - Running pre-action listener: _resource_record_pre_action 04:31:15 INFO - Running main action method: download_and_extract 04:31:15 INFO - mkdir: /builds/slave/test/build/tests 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:15 INFO - https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:31:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:31:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:31:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:31:16 INFO - Downloaded 1361 bytes. 04:31:16 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:31:16 INFO - Using the following test package requirements: 04:31:16 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:16 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:31:16 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:31:16 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'jsshell-linux-x86_64.zip'], 04:31:16 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:31:16 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:16 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:31:16 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:31:16 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:31:16 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:31:16 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:16 INFO - https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:31:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:31:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:31:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:17 INFO - Downloaded 22291553 bytes. 04:31:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:31:18 INFO - Return code: 0 04:31:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:18 INFO - https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:31:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:31:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:31:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:20 INFO - Downloaded 22291553 bytes. 04:31:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:31:21 INFO - Return code: 0 04:31: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')]} 04:31:21 INFO - https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:31:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:31:22 INFO - Downloaded 10840145 bytes. 04:31:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:31:22 INFO - Return code: 0 04:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:22 INFO - https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:31:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:31:24 INFO - Downloaded 54815609 bytes. 04:31:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:24 INFO - mkdir: /builds/slave/test/properties 04:31:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:24 INFO - Contents: 04:31:24 INFO - build_url:https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:25 INFO - Running post-action listener: _resource_record_post_action 04:31:25 INFO - Running post-action listener: set_extra_try_arguments 04:31:25 INFO - ##### 04:31:25 INFO - ##### Running populate-webroot step. 04:31:25 INFO - ##### 04:31:25 INFO - Running pre-action listener: _resource_record_pre_action 04:31:25 INFO - Running main action method: populate_webroot 04:31:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:25 INFO - '--tppagecycles', 04:31:25 INFO - '7'], 04:31:25 INFO - 'tests': ['tsvgm']}}, 04:31:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:25 INFO - 'talos_options': ['--disable-e10s'], 04:31:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:25 INFO - 'talos_options': ['--disable-e10s'], 04:31:25 INFO - 'tests': ['damp', 'tps']}, 04:31:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:25 INFO - 'tests': ['damp', 'tps']}, 04:31:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:25 INFO - 'tests': ['dromaeo_dom']}, 04:31:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:25 INFO - 'tests': ['a11yr', 04:31:25 INFO - 'ts_paint', 04:31:25 INFO - 'tpaint', 04:31:25 INFO - 'sessionrestore', 04:31:25 INFO - 'sessionrestore_no_auto_restore', 04:31:25 INFO - 'tabpaint']}, 04:31:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:25 INFO - 'ts_paint', 04:31:25 INFO - 'tpaint', 04:31:25 INFO - 'sessionrestore', 04:31:25 INFO - 'sessionrestore_no_auto_restore', 04:31:25 INFO - 'tabpaint']}, 04:31:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:25 INFO - 'ts_paint', 04:31:25 INFO - 'tpaint', 04:31:25 INFO - 'sessionrestore', 04:31:25 INFO - 'sessionrestore_no_auto_restore', 04:31:25 INFO - 'tabpaint']}, 04:31:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:25 INFO - 'ts_paint', 04:31:25 INFO - 'tpaint', 04:31:25 INFO - 'sessionrestore', 04:31:25 INFO - 'sessionrestore_no_auto_restore', 04:31:25 INFO - 'tabpaint']}, 04:31:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:25 INFO - 'tests': ['a11yr', 04:31:25 INFO - 'ts_paint', 04:31:25 INFO - 'tpaint', 04:31:25 INFO - 'sessionrestore', 04:31:25 INFO - 'sessionrestore_no_auto_restore', 04:31:25 INFO - 'tabpaint']}, 04:31:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:25 INFO - 'tests': ['a11yr', 04:31:25 INFO - 'ts_paint', 04:31:25 INFO - 'tpaint', 04:31:25 INFO - 'sessionrestore', 04:31:25 INFO - 'sessionrestore_no_auto_restore', 04:31:25 INFO - 'tabpaint']}, 04:31:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:25 INFO - 'tests': ['tsvgx', 04:31:25 INFO - 'tsvgr_opacity', 04:31:25 INFO - 'tart', 04:31:25 INFO - 'tscrollx', 04:31:25 INFO - 'cart']}, 04:31:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:25 INFO - 'tsvgr_opacity', 04:31:25 INFO - 'tart', 04:31:25 INFO - 'tscrollx', 04:31:25 INFO - 'cart']}, 04:31:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:25 INFO - 'talos_options': ['--disable-e10s'], 04:31:25 INFO - 'tests': ['tp5o']}, 04:31:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:25 INFO - 'tests': ['tp5o']}, 04:31:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:25 INFO - 'talos_options': ['--disable-e10s', 04:31:25 INFO - '--xperf_path', 04:31:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:25 INFO - 'tests': ['tp5n']}, 04:31:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:25 INFO - 'talos_options': ['--xperf_path', 04:31:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:25 INFO - 'tests': ['tp5n']}}, 04:31:25 INFO - 'talos.zip': {'path': '', 04:31:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:25 INFO - Running post-action listener: _resource_record_post_action 04:31:25 INFO - ##### 04:31:25 INFO - ##### Running create-virtualenv step. 04:31:25 INFO - ##### 04:31:25 INFO - Running pre-action listener: _resource_record_pre_action 04:31:25 INFO - Running main action method: create_virtualenv 04:31:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:31:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:25 INFO - Using real prefix '/usr' 04:31:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:27 INFO - Installing pip.................done. 04:31:27 INFO - Return code: 0 04:31:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:27 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 0x7fbf191c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c410>, '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 0x245d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d7a0>, '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': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:27 INFO - Using env: {'DISPLAY': ':0', 04:31:27 INFO - 'HOME': '/home/cltbld', 04:31:27 INFO - 'LANG': 'en_US.UTF-8', 04:31:27 INFO - 'LANGUAGE': 'en_US:en', 04:31:27 INFO - 'LOGNAME': 'cltbld', 04:31:27 INFO - 'MAIL': '/var/mail/cltbld', 04:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:27 INFO - 'MOZ_NO_REMOTE': '1', 04:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:27 INFO - 'NO_EM_RESTART': '1', 04:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:27 INFO - 'PWD': '/builds/slave/test', 04:31:27 INFO - 'SHELL': '/bin/bash', 04:31:27 INFO - 'SHLVL': '1', 04:31:27 INFO - 'TERM': 'linux', 04:31:27 INFO - 'TMOUT': '86400', 04:31:27 INFO - 'USER': 'cltbld', 04:31:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 04:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:27 INFO - '_': '/tools/buildbot/bin/python'} 04:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:31:28 INFO - Cleaning up... 04:31:28 INFO - Return code: 0 04:31:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:28 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 0x7fbf191c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c410>, '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 0x245d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d7a0>, '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': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:31:28 INFO - Using env: {'DISPLAY': ':0', 04:31:28 INFO - 'HOME': '/home/cltbld', 04:31:28 INFO - 'LANG': 'en_US.UTF-8', 04:31:28 INFO - 'LANGUAGE': 'en_US:en', 04:31:28 INFO - 'LOGNAME': 'cltbld', 04:31:28 INFO - 'MAIL': '/var/mail/cltbld', 04:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:28 INFO - 'MOZ_NO_REMOTE': '1', 04:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:28 INFO - 'NO_EM_RESTART': '1', 04:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:28 INFO - 'PWD': '/builds/slave/test', 04:31:28 INFO - 'SHELL': '/bin/bash', 04:31:28 INFO - 'SHLVL': '1', 04:31:28 INFO - 'TERM': 'linux', 04:31:28 INFO - 'TMOUT': '86400', 04:31:28 INFO - 'USER': 'cltbld', 04:31:28 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 04:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:28 INFO - '_': '/tools/buildbot/bin/python'} 04:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:28 INFO - Downloading/unpacking psutil>=0.7.1 04:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:30 INFO - Installing collected packages: psutil 04:31:30 INFO - Running setup.py install for psutil 04:31:30 INFO - building 'psutil._psutil_linux' extension 04:31:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:31:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:31:30 INFO - building 'psutil._psutil_posix' extension 04:31:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:31:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:30 INFO - Successfully installed psutil 04:31:30 INFO - Cleaning up... 04:31:30 INFO - Return code: 0 04:31:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:30 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 0x7fbf191c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c410>, '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 0x245d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d7a0>, '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': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:31:30 INFO - Using env: {'DISPLAY': ':0', 04:31:30 INFO - 'HOME': '/home/cltbld', 04:31:30 INFO - 'LANG': 'en_US.UTF-8', 04:31:30 INFO - 'LANGUAGE': 'en_US:en', 04:31:30 INFO - 'LOGNAME': 'cltbld', 04:31:30 INFO - 'MAIL': '/var/mail/cltbld', 04:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:30 INFO - 'MOZ_NO_REMOTE': '1', 04:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:30 INFO - 'NO_EM_RESTART': '1', 04:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:30 INFO - 'PWD': '/builds/slave/test', 04:31:30 INFO - 'SHELL': '/bin/bash', 04:31:30 INFO - 'SHLVL': '1', 04:31:30 INFO - 'TERM': 'linux', 04:31:30 INFO - 'TMOUT': '86400', 04:31:30 INFO - 'USER': 'cltbld', 04:31:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 04:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:30 INFO - '_': '/tools/buildbot/bin/python'} 04:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:31:33 INFO - Installing collected packages: mozsystemmonitor 04:31:33 INFO - Running setup.py install for mozsystemmonitor 04:31:33 INFO - Successfully installed mozsystemmonitor 04:31:33 INFO - Cleaning up... 04:31:33 INFO - Return code: 0 04:31:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:33 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 0x7fbf191c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c410>, '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 0x245d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d7a0>, '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': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:31:33 INFO - Using env: {'DISPLAY': ':0', 04:31:33 INFO - 'HOME': '/home/cltbld', 04:31:33 INFO - 'LANG': 'en_US.UTF-8', 04:31:33 INFO - 'LANGUAGE': 'en_US:en', 04:31:33 INFO - 'LOGNAME': 'cltbld', 04:31:33 INFO - 'MAIL': '/var/mail/cltbld', 04:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:33 INFO - 'MOZ_NO_REMOTE': '1', 04:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:33 INFO - 'NO_EM_RESTART': '1', 04:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:33 INFO - 'PWD': '/builds/slave/test', 04:31:33 INFO - 'SHELL': '/bin/bash', 04:31:33 INFO - 'SHLVL': '1', 04:31:33 INFO - 'TERM': 'linux', 04:31:33 INFO - 'TMOUT': '86400', 04:31:33 INFO - 'USER': 'cltbld', 04:31:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 04:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:33 INFO - '_': '/tools/buildbot/bin/python'} 04:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:33 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:35 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:35 INFO - Downloading docopt-0.6.1.tar.gz 04:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:36 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:36 INFO - Running setup.py install for blobuploader 04:31:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:36 INFO - Running setup.py install for requests 04:31:36 INFO - Running setup.py install for docopt 04:31:36 INFO - Successfully installed blobuploader requests docopt 04:31:36 INFO - Cleaning up... 04:31:36 INFO - Return code: 0 04:31:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:36 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 0x7fbf191c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c410>, '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 0x245d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d7a0>, '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': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:36 INFO - Using env: {'DISPLAY': ':0', 04:31:36 INFO - 'HOME': '/home/cltbld', 04:31:36 INFO - 'LANG': 'en_US.UTF-8', 04:31:36 INFO - 'LANGUAGE': 'en_US:en', 04:31:36 INFO - 'LOGNAME': 'cltbld', 04:31:36 INFO - 'MAIL': '/var/mail/cltbld', 04:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:36 INFO - 'MOZ_NO_REMOTE': '1', 04:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:36 INFO - 'NO_EM_RESTART': '1', 04:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:36 INFO - 'PWD': '/builds/slave/test', 04:31:36 INFO - 'SHELL': '/bin/bash', 04:31:36 INFO - 'SHLVL': '1', 04:31:36 INFO - 'TERM': 'linux', 04:31:36 INFO - 'TMOUT': '86400', 04:31:36 INFO - 'USER': 'cltbld', 04:31:36 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 04:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:36 INFO - '_': '/tools/buildbot/bin/python'} 04:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:36 INFO - Running setup.py (path:/tmp/pip-3uE1Zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:36 INFO - Running setup.py (path:/tmp/pip-qk9koj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:36 INFO - Running setup.py (path:/tmp/pip-UvO9O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:37 INFO - Running setup.py (path:/tmp/pip-ofUdAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:37 INFO - Running setup.py (path:/tmp/pip-KAEPHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:37 INFO - Running setup.py (path:/tmp/pip-vTzVRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:37 INFO - Running setup.py (path:/tmp/pip-HL2y7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:37 INFO - Running setup.py (path:/tmp/pip-9B15r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:37 INFO - Running setup.py (path:/tmp/pip-bwf0lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:37 INFO - Running setup.py (path:/tmp/pip-2v__IZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:37 INFO - Running setup.py (path:/tmp/pip-__Ibts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:37 INFO - Running setup.py (path:/tmp/pip-f8Et1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:37 INFO - Running setup.py (path:/tmp/pip-qfw7Bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:37 INFO - Running setup.py (path:/tmp/pip-CdTZlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:37 INFO - Running setup.py (path:/tmp/pip-TD5dvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:37 INFO - Running setup.py (path:/tmp/pip-jx7uiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:37 INFO - Running setup.py (path:/tmp/pip-HCWR9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:38 INFO - Running setup.py install for manifestparser 04:31:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:38 INFO - Running setup.py install for mozcrash 04:31:38 INFO - Running setup.py install for mozdebug 04:31:38 INFO - Running setup.py install for mozdevice 04:31:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:38 INFO - Running setup.py install for mozfile 04:31:38 INFO - Running setup.py install for mozhttpd 04:31:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:38 INFO - Running setup.py install for mozinfo 04:31:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:38 INFO - Running setup.py install for mozInstall 04:31:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:38 INFO - Running setup.py install for mozleak 04:31:38 INFO - Running setup.py install for mozlog 04:31:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:39 INFO - Running setup.py install for moznetwork 04:31:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:39 INFO - Running setup.py install for mozprocess 04:31:39 INFO - Running setup.py install for mozprofile 04:31:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:39 INFO - Running setup.py install for mozrunner 04:31:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:39 INFO - Running setup.py install for mozscreenshot 04:31:39 INFO - Running setup.py install for moztest 04:31:39 INFO - Running setup.py install for mozversion 04:31:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:39 INFO - Cleaning up... 04:31:39 INFO - Return code: 0 04:31:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 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 0x7fbf191c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c410>, '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 0x245d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d7a0>, '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': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:39 INFO - Using env: {'DISPLAY': ':0', 04:31:39 INFO - 'HOME': '/home/cltbld', 04:31:39 INFO - 'LANG': 'en_US.UTF-8', 04:31:39 INFO - 'LANGUAGE': 'en_US:en', 04:31:39 INFO - 'LOGNAME': 'cltbld', 04:31:39 INFO - 'MAIL': '/var/mail/cltbld', 04:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:39 INFO - 'MOZ_NO_REMOTE': '1', 04:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:39 INFO - 'NO_EM_RESTART': '1', 04:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:39 INFO - 'PWD': '/builds/slave/test', 04:31:39 INFO - 'SHELL': '/bin/bash', 04:31:39 INFO - 'SHLVL': '1', 04:31:39 INFO - 'TERM': 'linux', 04:31:39 INFO - 'TMOUT': '86400', 04:31:39 INFO - 'USER': 'cltbld', 04:31:39 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 04:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:39 INFO - '_': '/tools/buildbot/bin/python'} 04:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:40 INFO - Running setup.py (path:/tmp/pip-CNm45t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:40 INFO - Running setup.py (path:/tmp/pip-UBITDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:40 INFO - Running setup.py (path:/tmp/pip-haknZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:40 INFO - Running setup.py (path:/tmp/pip-GXj8Vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:40 INFO - Running setup.py (path:/tmp/pip-glzNdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:40 INFO - Running setup.py (path:/tmp/pip-u4NCNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:40 INFO - Running setup.py (path:/tmp/pip-C2cg8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:40 INFO - Running setup.py (path:/tmp/pip-yVafK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:40 INFO - Running setup.py (path:/tmp/pip-sQVyUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:40 INFO - Running setup.py (path:/tmp/pip-o2lzQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:40 INFO - Running setup.py (path:/tmp/pip-1160S_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:40 INFO - Running setup.py (path:/tmp/pip-Aax28g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:40 INFO - Running setup.py (path:/tmp/pip-6R4lf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:41 INFO - Running setup.py (path:/tmp/pip-ftRrEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:41 INFO - Running setup.py (path:/tmp/pip-iYQZdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:41 INFO - Running setup.py (path:/tmp/pip-mJHzxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:41 INFO - Running setup.py (path:/tmp/pip-PbOBdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:43 INFO - Downloading blessings-1.6.tar.gz 04:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:43 INFO - Installing collected packages: blessings 04:31:43 INFO - Running setup.py install for blessings 04:31:43 INFO - Successfully installed blessings 04:31:43 INFO - Cleaning up... 04:31:43 INFO - Return code: 0 04:31:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:43 INFO - Reading from file tmpfile_stdout 04:31:43 INFO - Current package versions: 04:31:43 INFO - argparse == 1.2.1 04:31:43 INFO - blessings == 1.6 04:31:43 INFO - blobuploader == 1.2.4 04:31:43 INFO - docopt == 0.6.1 04:31:43 INFO - manifestparser == 1.1 04:31:43 INFO - mozInstall == 1.12 04:31:43 INFO - mozcrash == 0.17 04:31:43 INFO - mozdebug == 0.1 04:31:43 INFO - mozdevice == 0.48 04:31:43 INFO - mozfile == 1.2 04:31:43 INFO - mozhttpd == 0.7 04:31:43 INFO - mozinfo == 0.9 04:31:43 INFO - mozleak == 0.1 04:31:43 INFO - mozlog == 3.1 04:31:43 INFO - moznetwork == 0.27 04:31:43 INFO - mozprocess == 0.22 04:31:43 INFO - mozprofile == 0.28 04:31:43 INFO - mozrunner == 6.11 04:31:43 INFO - mozscreenshot == 0.1 04:31:43 INFO - mozsystemmonitor == 0.0 04:31:43 INFO - moztest == 0.7 04:31:43 INFO - mozversion == 1.4 04:31:43 INFO - psutil == 3.1.1 04:31:43 INFO - requests == 1.2.3 04:31:43 INFO - wsgiref == 0.1.2 04:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 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 0x7fbf191c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c410>, '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 0x245d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d7a0>, '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': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:43 INFO - Using env: {'DISPLAY': ':0', 04:31:43 INFO - 'HOME': '/home/cltbld', 04:31:43 INFO - 'LANG': 'en_US.UTF-8', 04:31:43 INFO - 'LANGUAGE': 'en_US:en', 04:31:43 INFO - 'LOGNAME': 'cltbld', 04:31:43 INFO - 'MAIL': '/var/mail/cltbld', 04:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:43 INFO - 'MOZ_NO_REMOTE': '1', 04:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:43 INFO - 'NO_EM_RESTART': '1', 04:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:43 INFO - 'PWD': '/builds/slave/test', 04:31:43 INFO - 'SHELL': '/bin/bash', 04:31:43 INFO - 'SHLVL': '1', 04:31:43 INFO - 'TERM': 'linux', 04:31:43 INFO - 'TMOUT': '86400', 04:31:43 INFO - 'USER': 'cltbld', 04:31:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 04:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:43 INFO - '_': '/tools/buildbot/bin/python'} 04:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:43 INFO - Cleaning up... 04:31:43 INFO - Return code: 0 04:31:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 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 0x7fbf191c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c410>, '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 0x245d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d7a0>, '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': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:31:43 INFO - Using env: {'DISPLAY': ':0', 04:31:43 INFO - 'HOME': '/home/cltbld', 04:31:43 INFO - 'LANG': 'en_US.UTF-8', 04:31:43 INFO - 'LANGUAGE': 'en_US:en', 04:31:43 INFO - 'LOGNAME': 'cltbld', 04:31:43 INFO - 'MAIL': '/var/mail/cltbld', 04:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:43 INFO - 'MOZ_NO_REMOTE': '1', 04:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:43 INFO - 'NO_EM_RESTART': '1', 04:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:43 INFO - 'PWD': '/builds/slave/test', 04:31:43 INFO - 'SHELL': '/bin/bash', 04:31:43 INFO - 'SHLVL': '1', 04:31:43 INFO - 'TERM': 'linux', 04:31:43 INFO - 'TMOUT': '86400', 04:31:43 INFO - 'USER': 'cltbld', 04:31:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 04:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:43 INFO - '_': '/tools/buildbot/bin/python'} 04:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:44 INFO - Downloading/unpacking jsonschema 04:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:45 INFO - Downloading/unpacking functools32 (from jsonschema) 04:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:46 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:46 INFO - warning: no files found matching '*.txt' 04:31:46 INFO - no previously-included directories found matching 'build' 04:31:46 INFO - no previously-included directories found matching 'dist' 04:31:46 INFO - no previously-included directories found matching '.git*' 04:31:46 INFO - Installing collected packages: jsonschema, functools32 04:31:46 INFO - Running setup.py install for functools32 04:31:46 INFO - warning: no files found matching '*.txt' 04:31:46 INFO - no previously-included directories found matching 'build' 04:31:46 INFO - no previously-included directories found matching 'dist' 04:31:46 INFO - no previously-included directories found matching '.git*' 04:31:46 INFO - Successfully installed jsonschema functools32 04:31:46 INFO - Cleaning up... 04:31:46 INFO - Return code: 0 04:31:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf191c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c410>, '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 0x245d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d7a0>, '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': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31: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', 'flake8'] in /builds/slave/test/build 04:31: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 flake8 04:31:46 INFO - Using env: {'DISPLAY': ':0', 04:31:46 INFO - 'HOME': '/home/cltbld', 04:31:46 INFO - 'LANG': 'en_US.UTF-8', 04:31:46 INFO - 'LANGUAGE': 'en_US:en', 04:31:46 INFO - 'LOGNAME': 'cltbld', 04:31:46 INFO - 'MAIL': '/var/mail/cltbld', 04:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:46 INFO - 'MOZ_NO_REMOTE': '1', 04:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:46 INFO - 'NO_EM_RESTART': '1', 04:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:46 INFO - 'PWD': '/builds/slave/test', 04:31:46 INFO - 'SHELL': '/bin/bash', 04:31:46 INFO - 'SHLVL': '1', 04:31:46 INFO - 'TERM': 'linux', 04:31:46 INFO - 'TMOUT': '86400', 04:31:46 INFO - 'USER': 'cltbld', 04:31:46 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 04:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:46 INFO - '_': '/tools/buildbot/bin/python'} 04:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:46 INFO - Downloading/unpacking flake8 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:31:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:31:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:31:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:49 INFO - no previously-included directories found matching 'docs/_build' 04:31:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:31:49 INFO - Running setup.py install for pep8 04:31:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:49 INFO - no previously-included directories found matching 'docs/_build' 04:31:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:31:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:31:49 INFO - Cleaning up... 04:31:49 INFO - Return code: 0 04:31:49 INFO - Running post-action listener: _resource_record_post_action 04:31:49 INFO - Running post-action listener: _start_resource_monitoring 04:31:49 INFO - Starting resource monitoring. 04:31:49 INFO - ##### 04:31:49 INFO - ##### Running install step. 04:31:49 INFO - ##### 04:31:49 INFO - Running pre-action listener: _resource_record_pre_action 04:31:49 INFO - Running main action method: install 04:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:49 INFO - Reading from file tmpfile_stdout 04:31:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:49 INFO - Reading from file tmpfile_stdout 04:31:49 INFO - Output received: 04:31:49 INFO - Usage: mozinstall [options] installer 04:31:49 INFO - Options: 04:31:49 INFO - -h, --help show this help message and exit 04:31:49 INFO - -d DEST, --destination=DEST 04:31:49 INFO - Directory to install application into. [default: 04:31:49 INFO - "/builds/slave/test"] 04:31:49 INFO - --app=APP Application being installed. [default: firefox] 04:31:49 INFO - mkdir: /builds/slave/test/build/application 04:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:32:05 INFO - Reading from file tmpfile_stdout 04:32:05 INFO - Output received: 04:32:05 INFO - /builds/slave/test/build/application/firefox/firefox 04:32:05 INFO - Running post-action listener: _resource_record_post_action 04:32:05 INFO - ##### 04:32:05 INFO - ##### Running run-tests step. 04:32:05 INFO - ##### 04:32:05 INFO - Running pre-action listener: _resource_record_pre_action 04:32:05 INFO - Running main action method: run_tests 04:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:05 INFO - Python 2.7.3 04:32:05 INFO - Return code: 0 04:32:05 INFO - grabbing minidump binary from tooltool 04:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:05 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 0x245c410>, '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 0x245d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:32:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:32:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:05 INFO - Return code: 0 04:32:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:32:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:32:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:32:06 INFO - Return code: 0 04:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:32:06 INFO - Using env: {'DISPLAY': ':0', 04:32:06 INFO - 'HOME': '/home/cltbld', 04:32:06 INFO - 'LANG': 'en_US.UTF-8', 04:32:06 INFO - 'LANGUAGE': 'en_US:en', 04:32:06 INFO - 'LOGNAME': 'cltbld', 04:32:06 INFO - 'MAIL': '/var/mail/cltbld', 04:32:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:06 INFO - 'MOZ_NO_REMOTE': '1', 04:32:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:06 INFO - 'NO_EM_RESTART': '1', 04:32:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:06 INFO - 'PWD': '/builds/slave/test', 04:32:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:06 INFO - 'SHELL': '/bin/bash', 04:32:06 INFO - 'SHLVL': '1', 04:32:06 INFO - 'TERM': 'linux', 04:32:06 INFO - 'TMOUT': '86400', 04:32:06 INFO - 'USER': 'cltbld', 04:32:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461756673.468384-2022228199', 04:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:06 INFO - '_': '/tools/buildbot/bin/python'} 04:32:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:32:06 INFO - mozversion application_buildid: 20160427025603 04:32:06 INFO - mozversion application_changeset: 488df90abd620538454e58ae0a75f13453f391b1 04:32:06 INFO - mozversion application_display_name: Nightly 04:32:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:06 INFO - mozversion application_name: Firefox 04:32:06 INFO - mozversion application_remotingname: firefox 04:32:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:32:06 INFO - mozversion application_vendor: Mozilla 04:32:06 INFO - mozversion application_version: 49.0a1 04:32:06 INFO - mozversion platform_buildid: 20160427025603 04:32:06 INFO - mozversion platform_changeset: 488df90abd620538454e58ae0a75f13453f391b1 04:32:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:32:06 INFO - mozversion platform_version: 49.0a1 04:32:06 INFO - using testdate: 1461756726 04:32:06 INFO - actual date: 1461756726 04:32:06 INFO - starting webserver on 'localhost:50602' 04:32:06 INFO - SUITE-START | Running 2 tests 04:32:06 INFO - TEST-START | dromaeo_css 04:32:06 INFO - operating with platform_type : linux_ 04:32:06 INFO - Initialising browser for dromaeo_css test... 04:32:06 INFO - TEST-INFO | started process 13460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Z6LYM/profile http://localhost:50602/getInfo.html) 04:32:11 INFO - PROCESS | 13460 | __metrics Screen width/height:1600/1200 04:32:11 INFO - PROCESS | 13460 | colorDepth:24 04:32:11 INFO - PROCESS | 13460 | Browser inner width/height: 1024/697 04:32:11 INFO - PROCESS | 13460 | __metrics 04:32:12 ERROR - PROCESS | 13460 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:32:13 INFO - TEST-INFO | 13460: exit 0 04:32:13 INFO - Browser initialized. 04:32:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:13 INFO - TEST-INFO | started process 13541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Z6LYM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:25 INFO - PROCESS | 13541 | RSS: Main: 156127232 04:32:25 INFO - PROCESS | 13541 | 04:33:16 INFO - PROCESS | 13541 | 1461756796591 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:35:27 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:50602/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50602/tests/dromaeo/cssquery-ext.html) 04:35:29 INFO - PROCESS | 13541 | RSS: Main: 267661312 04:35:29 INFO - PROCESS | 13541 | 04:38:31 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:50602/tests/dromaeo/cssquery-ext.html (next: http://localhost:50602/tests/dromaeo/cssquery-jquery.html) 04:38:32 INFO - PROCESS | 13541 | RSS: Main: 235642880 04:38:32 INFO - PROCESS | 13541 | 04:41:34 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:50602/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50602/tests/dromaeo/cssquery-mootools.html) 04:41:35 INFO - PROCESS | 13541 | RSS: Main: 240513024 04:41:35 INFO - PROCESS | 13541 | 04:44:37 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:50602/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50602/tests/dromaeo/cssquery-prototype.html) 04:44:37 INFO - PROCESS | 13541 | RSS: Main: 235044864 04:44:37 INFO - PROCESS | 13541 | 04:47:40 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:50602/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50602/tests/dromaeo/cssquery-yui.html) 04:47:41 INFO - PROCESS | 13541 | RSS: Main: 215035904 04:47:41 INFO - PROCESS | 13541 | 04:50:43 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:50602/tests/dromaeo/cssquery-yui.html (next: http://localhost:50602/tests/dromaeo/cssquery-dojo.html) 04:50:44 INFO - PROCESS | 13541 | RSS: Main: 266063872 04:50:44 INFO - PROCESS | 13541 | 04:50:44 INFO - PROCESS | 13541 | __start_tp_report 04:50:44 INFO - PROCESS | 13541 | _x_x_mozilla_page_load 04:50:44 INFO - PROCESS | 13541 | _x_x_mozilla_page_load_details 04:50:44 INFO - PROCESS | 13541 | |i|pagename|runs| 04:50:44 INFO - PROCESS | 13541 | |0;dojo.html;2588.585826267797;2662.0150544298626;2666.3867310518594;2679.303381120908;2695.9865200674;4505.909881802362;4593.242115051021;4666.883327916799;4673.813047478101;4691.179043667362;4631.8147274109;4652.627789776819;4657.394538709963;4679.251319788835;4704.670673052888;4191.916161676764;4200.1179752252065;4218.472690913643;4264.296391095481;4376.212281789277;4334;4352.107817897339;4360.302351623741;4403.207422663919;4412.426384570002;4135.669146468305;4212.304969679999;4244.342126970325;4250.298700714409;4311.00846805235;4233.745975241495;4266;4272.124214536044;4273.764942928137;4313.223619748444;4237.194932962727;4250.404943307939;4264.957350426487;4265.232258193524;4305.009847735038;4353.891152721208;4479.977600112011;4536.591706746409;4540.18276710192;4560.543945605446;4861.9027619447415;4882.853514394538;4892.755362231874;4895.11887860185;4909.189983652693;4855.514448555152;4888.144574699449;4910.533499317559;4928.137575924235;4945.455999840015;4519.638428925645;4602.585767280927;4652.13935421948;4730.810767569327;4740.19416699162;5027.4218464877;5034.723090230073;5036.874078148076;5043.99120175959;5092.490750924878;4826.469088400273;4831.0820944020525;4831.589314908202;4850.490698476679;4892.315075889378;4751.097291514601;4871.707697538159;4911;4957.752112394366;4960.057589058068;4951.356323677899;4953.182724850431;4962;4967.2549117631925;5019.447860735316;4724.574788269072;4938.38270216223;4945.703257804544;4953.25701144824;5008.449070602231;4110.219058378899;4119.8352065917625;4148.979255103765;4230.703850730481;4246.766427846498;3620.3664358737115;3651.561812582454;3662.2675464907124;3690.5755838078962;3697.2975134724315;4266.0827921996915;4269.509006464296;4274.935875961863;4276.444062271885;4317.481902171759;4876.902461950741;4949;4989.476105008995;5032.194848824171;5037.345145131109;4294.892627684333;4303.376010478463;4324.416203812445;4324.545922678073;4363.192809330284;4363.323684828857;4513.842015529441;4521.299198624219;4521.977390113028;4556.703814252063;4466.441694788216;4682.344471773954;4712.764361781966;4716.221823399238;4760.071786001697;4963.429205641253;4972.552470277692;4972.925406118983;4974.228994505857;4988.975055124846;4508.120916421266;4687.953120468752;4693.483716791218;4705.176594095951;4736.076465089274;4872.537108974641;4873.293372461044;4892.8532144035735;4937.061958227925;4940.209566469348;4899.608031357411;4931.580815630568;4932.988173796816;4934.284528743384;4981.825636102719;4674;4711.481737008995;4802.063597598435;4805.423349198119;4835.758212089452;4834.274858771212;4847;4859.246816743411;4859.343988561499;4898.118338699069;4763.523647635208;4766.213574760126;4768.1417344878255;4776.522347765334;4804.351412559399;4737.620990320835;4804.567588917014;4873.074115917964;4906.730129842893;4914.606831453403;4816.34979277807;4841.176999910094;4843.685160464699;4850.369451971221;4882.145624515624 04:50:44 INFO - PROCESS | 13541 | |1;ext.html;567.9488846003859;590.1266126133322;592.6118392452942;612.2408213814865;613.3651670521009;25257.36856578584;31970;31997.840010799944;32741;32785;33526.49710254348;34169.487457688156;34206.486902696415;34220.657793422055;34221;7035.472339574552;7406.592637404954;7614.923850761477;7616.695332186706;7618.200088990659;9149.542522873862;9469.952650236739;9487.905120948772;9497.145256926875;9503.857442138373;9483.62065517382;9643.083907028857;9650.855237171449;9656.468894210815;9656.662016829412;9443.527823608827;9552.044795520462;9556.283278754121;9582.329236953416;9582.472963986978;9371;9468.668596599155;9487.905120948772;9496.145346918742;9748.073932976356;33463.163420914425;34130.48804267938;34142.14644633879;34150.14624634379;34178.65821341804;2869.7991140620165;2871.181713211725;2911.5195992661183;3119.298157914474;3728.440733889911;25687;26353.07764228262;26481.337966550796;26754.866225668746;27109.186724398103;3425.2635683327953;3443.724502039831;3524.400851855191;3539.522164507784;3603.657652523006;186552;188182;190186;190277.04861475743;190774;47096.5290347099;47417;47517.524824752;47539.76230118897;47570;49569.50430495721;49651;49699.75150124299;49787.50212497901;49841;10839.512221950032;13703.177809331472;13953.093048951785;13966.441342346396;13980.51068212628;8180.386471014698;8323.375746819012;10027.548760305805;10047.748806279902;10358.274920755475;13844.653883652989;13916.443342266197;14075.507357242448;14104;14224.85775142256;5309.893802124013;5382.192671099288;5413.458654134633;5419.132938729863;5533.418991005967;853.0957185383513;894.9776255593532;897.434616191795;941.1905761045496;991.8809742830762;24847.751522484905;26664.20007399781;26688.866555667097;26759.732402675723;26778.794954226716;894.2041582991143;964.1749673456699;974.4786539201493;998.1515711645188;1072.3673032910465;13627.795583066261;14078.2960851957;14138.64653383653;14304.998650094394;14362.569122926328;260819;262241;264683;264686;264897;44538.77730611326;44735.32897006548;44737.32894006593;44759.32861007087;44811;1098.8846171152074;1193.8567371915426;1227.2391117507202;1230.2802860326808;1309.4762095162012;23893.805309734096;26181.476370472104;27182.184534464;27189.320266993484;27275.181744547695;36555.26889462249;36967.26065478729;37022.259554809294;37023.629763703095;37031.62968370282;170666;171557;171836;182856;183160.08419957815;25879.741202588488;28676.713232867405;30521.542176866922;30820.691793081784;30962.53556196614;33254.96602976606;34204.14489637779;34267.314653706286;34292.314153717285;34327.141821454665;28326;29672;29965;29994.550081748355;30284.24289392783;29767.702322976493;30130;31580.210494737814;32174.356512869144;32629.495216100906;29055.56416653794;29650.406991860473;29752.404951901273;29941.401171976875;30072.097837064925;26662;27409.588856166774;28846.423071538873;29982.70017299799;30183.547246791753;22841.42896427536;23287.1849485274;23425.297241082793;23445.648315274942;23590.29229123129 04:50:44 INFO - PROCESS | 13541 | |2;jquery.html;378.95263092113487;379.83287353564447;380.3894748927971;382.2469734622793;389.07012240744626;15003.624909377257;15857.682846343081;16189.595260118473;16200;16203.270852811607;14618.195999220039;14843.332050057747;14918.85081149191;14967.925160374183;15007.174605396698;4609.7003694759815;4794.184988551954;4798.184308667535;4799.448063472711;4803.423589169304;3586.372384832644;4609.631229501649;5447.400785913546;5752.36723960364;5773.509251713609;5831.037878750001;5835.474807267345;5841.240638716961;5864.091065884794;5866.706664666771;5683.090705487102;5776.5089967352615;5837.357890632027;5881.970590147064;5885.234919460464;3325.584301962255;4854.150523658345;5079.644424890259;5111.795528178868;5111.897762044776;18500.537486562807;19215.231390744353;19248.807511924842;19295.324663636704;19333;1901.496103532565;1904.6762050451457;1994.3518356534184;2185.4208634711813;2485.8881350339097;12157.392130393533;12315.630531084082;12377.443015064344;12752.2986235757;13013.414396352187;1773.3704534890057;1816.9091545422675;1967.5376286572643;1998.4204580671587;2005.5387260929922;49958;51554.22668659973;51604.22593661098;51906.22140667893;52124.73937630325;9389.530523473935;9588.137067663803;9623.663171788954;9717.6598819041;10079.848802267972;13734.793978090336;13742.793858092136;13796.379162937692;13836.792448113287;13848.169109853441;7061.717531298793;7078.292170782984;7127.358537731526;7183.92816071843;7313.707451701979;6860.416864566568;6868.012414599665;6883.65581720912;6973.372396484239;7016.36852683261;4216.789160541961;4369.71596846204;4421.756803375781;4479.081788233404;4489.191945449785;1693.3226709316125;1729.1959238953946;1813.6282062177222;1843.695790194603;1854.7774267087766;791.1455627921831;833.3624777045565;871.9738407847775;887.6316328723508;899.7120921305119;14554.053986490844;14630.26848657563;15480.612984675248;15509.069455832687;15872.44446444369;833.0960907415401;839.5172775653901;859.6991053131354;867.3408209760502;927.6150397584927;8807.559622019002;8920.643174272956;9133.862992055125;9224.30817688676;9386;344681;347459;349237;349325;354156;63929;64787.35212647813;65070.349296507375;65914.34085659082;67283.66358168177;905.6558507767138;920.5351297594672;931.4737173496952;937.9108984646448;978.3640633588225;14360.44507287164;14988.47540336083;15243.923780381027;15330.846691532943;15418.152001640017;31541.59075594581;32112.518312225802;32485.512717308786;33378.49932251067;33411.33177336391;43736.343954840064;44507.777461112484;44835.55164448314;44888.32667510055;45179.77410112928;7645.770626881203;7708.267714567107;7734.690612375442;7842.882356764539;7919.683212671659;10699.732506687395;11211.88788112141;11223.4388280584;11319.943400282946;11330.60342887995;9594.856077158987;9787.902120978984;9834.508274586098;9994.900050999688;9995.300328976902;9873.703788886345;9946.35348702332;10034.69895903124;10089.445080520349;10175.135113515138;5756.539476841926;6542;10144.137748291183;10251.641192558225;10270.948645256725;7490.662920168496;7767.495112817649;7788.9610551949145;7854;7922.603869806602;9405.153536181777;10020.799584008424;10050;10134.23993200498;10349.824465304067 04:50:44 INFO - PROCESS | 13541 | |3;mootools.html;1214.3624597086523;1394.7768357062869;1432.520105764569;1478.9334479948402;1641.3516660918938;6424.903626445607;7295.124585049794;7444.10670719513;7470.140933792615;7478.96260518698;7149.463790215728;7308.890366644505;7309.232530584291;7312.085989251344;7316.122065352152;2154.8168405685537;2185.3771675072608;2188.5732282204976;2190.200576789476;2192.6710993350966;2130.7869213078648;2157.7626461089267;2192.7807219278025;2192.8684278943233;2201.515666553356;2146.527763891941;2165.231342873281;2185.158713895154;2185.5956648020087;2188.7482939462006;2131.765505794361;2136.2950226425396;2138.230237114645;2142.1966762464076;2143.7856214378517;2113.8625989310644;2152.9892350538303;2155.9245426410002;2162.967555486669;2164.7618761936333;7331.303526165006;7400.481966262364;7420.5547667140145;7454.366378857803;7460.589667568282;4496.842610508616;4643.512431194744;4649.279361698942;4663.953360466419;4686.062787442525;2877.2375320540073;2900.5939168516425;2906.099109276131;2944.4258369617933;2962.614860068199;882.4220135811054;895.5746020640208;896.6054935828215;913.2602591900582;920.2040235196574;10127.898721012769;10157.441340726331;10304.742381440448;10312.226583006304;10362.533685984074;4046.2312160689376;4065.4511640928686;4139.441175441337;4147.066909945299;4218.029853133735;8187.549684767276;8259.876101858477;8276.255137037575;8278.875816862752;8297.543635100128;4535.229011068126;4573.291139873325;4588.7246765194195;4590.104929538775;4597.540245975376;3602.7117830573493;4159.355299928456;4211.115665710236;4247.787610619456;4342.609165175149;3339.749518786101;3365.5793025871767;3401.3027329397414;3501.9474707879403;3514.578250609943;1051.4427353502656;1056.7622284985816;1058.8888166742536;1065.8880817514205;1087.423665457309;674.6289540752566;783.5494590610308;856.7943693513637;872.1365847810748;886.8581027035773;4787.832425865078;4825.9034819303415;5076.568491678175;5080.898382032413;5187.507186817246;840.0926998841237;856.2764464027887;865.9824705970459;892.3084609427616;900.0504467786417;3291.687289707474;3323.152596087982;3374.5950485941844;3393.1347506385714;3514.7715398499017;8962.32782541312;9354.672586459441;9426.104520070583;9444.716658500256;9446.811063778687;9269.814603707888;9280.211182049467;9343.486108263975;9364;9367.297452691075;7256.96371518139;7271.818204544823;7311.963440182765;7383.6677349519405;7412.629368531552;4944.283078953604;5045.949540504548;5095.87260318495;5141.53726164647;5194.402643696023;8597.613107410307;8782.385233033627;8827.470351778913;8839.734807955772;9051.818963620559;9079;9153.725388238363;9157;9216.170544651013;9235.492047937429;6558.311377305315;6643.833904152435;6653.534252602465;6757.763478278237;6797.796066118024;7193.676284567103;7237.529560578546;7299.379552738077;7328.120625524758;7345.155307139534;6464.191976003;6602.570832896038;6617.404433600999;6678.766243181465;6686.197656281277;6670.299618539983;6700.229473610597;6716.1604799400075;6737.898931515933;6787;6018.067199584071;6027.156198132353;6044.969775151272;6057.939420605738;6063.029915213545;4386.166628340605;4423.181711383404;4541.772911354486;4552.704074235164;4575.313702944585;4444.1333939881415;4494.078713863585;4590.931136033029;4599.1721490132095;4620.884477888079 04:50:44 INFO - PROCESS | 13541 | |4;prototype.html;295.8698172803966;296.61143901489044;298.10568295114655;298.23205246490295;301.3385618567245;4708.36437080994;4713.269443236295;4714.457837348702;4718.268668356411;4746.193147164981;4697.224957881946;4705.035467729116;4716.127516409467;4719.50445203253;4731.763411829404;3554.1825380162513;3638.381475149231;3709.8516059357594;3743.28877513273;3765.213741831039;3711.6659500644937;3732.7760334379886;3745.2509498100353;3749.362608356586;3764.7246895201215;3521.295740851827;3711.2206436648203;3716.869909553166;3727.7949712765785;3730.5336832895887;3592.1558433768173;3728.925421491555;3742.1954279829965;3748.643878831534;3762.3792074307707;3307.7023067924;3325.451300535433;3326.1185785766793;3329.5505106810756;3340.9331813363597;4529.728216307032;4535.478419981711;4539.137563862855;4540.842085268268;4553.977230113861;3950.8222130003933;4201.243776120297;4246.214450326699;4277.615014648665;4304.956950430487;4933.309336692866;4948.87627809304;4964.826231081931;4976.527229913152;4982.800687972477;3529.400001999666;3532.540769699948;3539.486774417695;3547.6807087362004;3549.964500354989;4951.257311403282;5133.307003554547;5166.560842328407;5214.8174813881715;5230.163173892197;3599.1541987632886;3612.8916132516065;3617.330793803155;3619.873304434385;3625.3474374612824;3634.672879440863;3657.798821064867;3669.7614655047337;3678.70570354371;3679.576848662438;4176.851365874409;4190.099128687347;4195.643370313496;4196.685248606367;4209.158168366339;4854.80580776765;4988.575971042502;4995.900081998412;5004.84985450437;5009.223570346602;1324.6754545136503;1327.1638867513404;1327.9070465067352;1333.6599167212298;1336.432016393029;820.122468958209;874.5845723281518;876.3777717820419;892.9687460938836;894.4677916639589;4603.240465323252;4612.86161415158;4625.444946606429;4632.583067523871;4656.859069527987;5410.8917821643345;5411.458854114557;5428.398622406399;5436.972815135899;5441.2654291670115;4511.796969136397;4602.930956035662;4622.19111655459;4624.907501850012;4641.978764671767;2869.1249169003236;2871.0812539987005;2886.1918662774456;2901.448724742292;2903.7386635202934;5132.050570644443;5135.15269980449;5141.53726164647;5142.61430392722;5142.97428512855;5382.542483888835;5520.702634880799;5562.833115006556;5570.860728481739;5591.776328946797;5053.2420136979745;5086.364204474441;5086.4659210783075;5095.87260318495;5110.6678065926335;5413.702246376487;5421.241026256406;5445.292112025411;5466.797304592983;5471.343438787371;4876.244182151772;5117.692938423706;5129.153689641316;5136.481510165549;5141.53726164647;4891.339669144762;4913.361263035782;4936.802527898987;4949.82675606352;4958.231474121517;3653.7442379033214;3691.7969511677115;3696.4085746280466;3700.7594506358078;3707.1102935295876;5121.359830021247;5155.819546315861;5168.147255702917;5175.81884634051;5187.688738675692;4996.525330093636;5019;5019.347484826949;5023.723695196653;5043.84868453947;5016.799328026838;5023.7488125592845;5025.1959686451455;5041.46235398207;5050.217216331474;4701.670883038155;4723.716577005391;4950.6782059166035;4987.625928055338;5006.549410552922;4913.975430122827;4976.979719157636;4977.228529577921;4994.850154495371;5001.699898006132;4937;4956.454789973172;4990.301357809982;5008.649394542347;5009.123403404316 04:50:44 INFO - PROCESS | 13541 | |5;yui.html;602.710698864545;734.7244783206297;738.5679377564123;758.9279018493241;762.9694812207508;12078.335691536962;12326.445309961051;12333.876661233397;12342.753144937096;12552.309622970733;12023.51905923762;12031.398430078505;12116.151869369147;12116.394180290972;12116.69708257294;636.2841802971657;778.0818634011864;795.49883573349;800.9359251259914;812.4556547113418;801.282851847596;804.7666176808718;807.2694211738357;807.5033854179696;809.5345176523493;840.277361469136;843.5149788871393;843.5824266987819;843.8185790055137;844.6452489954233;664.8803215421223;814.1370147643516;834.3700506117902;839.3201506779528;839.3369238301734;615.4952938590358;615.806021103351;615.8614311779813;616.1558664629441;616.2266355723583;12191.573294934635;12269.57056503027;12317.568885088978;12324.32216228107;12366.134370594062;12140.968017718504;12264.202826816228;12597.867254826588;12685.873141268561;12826.166299190523;7915.248051435105;8134.6746130154725;8436.662533498653;8564.61459234336;8803.691870784492;3334.333133373311;3398.048546406985;3412.9829350853333;3415.3852306584804;3435.4503279475416;40376.79811600952;40556.39165412521;42134;42240.155196896194;42550.148997020195;9628.518574071268;9973.950130249448;10054.949725251327;10101.94949025265;10216.182705383551;15865.286062127232;15947.282372293275;16002.439914603166;16058.357665693475;16122.274497647633;6379.617222966637;6481.254900393984;6638.96680516604;6641.900371494431;6835.213950395669;3737.4020156774786;3737.9813100934866;3837.424386342071;3838.481804956295;3845.2117315950163;2762.5441802102428;2829.8019138660507;2882.524383476703;2884.1780092673907;2892.783041271913;513.6969188178992;525.9421463638996;535.3094508084528;537.0252990821646;538.1927109335996;458.191292368969;522.5845452864982;537.2666310486236;548.8638518267228;609.4180058044557;7465.776026719207;7569.659365328574;7626;7871.370290376756;7881.645325960231;592.8399332180287;597.4413922981939;607.2864384348374;610.206731249374;624.1511544299749;3496.2133519957806;3576.3741345264993;3576.678098971105;3600.261946301002;3633.818309084535;37023.81488092542;37119;49561;52784.73607632014;54261.1860822088;43533.56466435359;43543.782281088395;43869.78065109718;44024.779876100416;47426.5257347429;42520;42983.78508107439;43053.56946430558;43369.57880264904;43743.34384984228;7079.575225486487;7280.526765760421;7295.2340004298785;7379.151397589346;7411.62941852916;27200.455990880466;27900.720992790626;28154;28517.714822851507;29033;40014.799926001346;41512.1697566041;41688.1662366757;41741.1651766969;42531.574684253996;10819.513121909376;10827.621033263798;11095;11228.831567526331;11235.06371163654;11487.54049837997;12405.689857753629;12425.316607586308;12527.749445010866;12559.497620095093;10508.42203678805;10670.893291067301;10775.892241077489;10790.244682872124;10794.892051079703;9155.323699306473;9814.803703926023;10033.397996120257;10495.580176792842;10568;10420.270581059556;10441.791164176522;10506.474676266003;10691.358518488916;10893.727656808644;9859.408435493893;9881.901180988098;9927.751806204902;9952;10413.323133996266;9323.533823308671;9439.480828554495;9535.47554884488;9573.18627916635;9621.470819105016 04:50:44 INFO - PROCESS | 13541 | __end_tp_report 04:50:44 INFO - PROCESS | 13541 | __start_cc_report 04:50:44 INFO - PROCESS | 13541 | _x_x_mozilla_cycle_collect,1110 04:50:44 INFO - PROCESS | 13541 | __end_cc_report 04:50:44 INFO - PROCESS | 13541 | __startTimestamp1461757844115__endTimestamp 04:50:44 INFO - PROCESS | 13541 | 04:50:44 INFO - PROCESS | 13541 | ------- Summary: start ------- 04:50:44 INFO - PROCESS | 13541 | Number of tests: 6 04:50:44 INFO - PROCESS | 13541 | 04:50:44 INFO - PROCESS | 13541 | [#0] dojo.html Cycles:165 Average:4578.75 Median:4716.22 stddev:466.68 (9.9%) stddev-sans-first:441.22 04:50:44 INFO - PROCESS | 13541 | Values: 2588.6 2662.0 2666.4 2679.3 2696.0 4505.9 4593.2 4666.9 4673.8 4691.2 4631.8 4652.6 4657.4 4679.3 4704.7 4191.9 4200.1 4218.5 4264.3 4376.2 4334.0 4352.1 4360.3 4403.2 4412.4 4135.7 4212.3 4244.3 4250.3 4311.0 4233.7 4266.0 4272.1 4273.8 4313.2 4237.2 4250.4 4265.0 4265.2 4305.0 4353.9 4480.0 4536.6 4540.2 4560.5 4861.9 4882.9 4892.8 4895.1 4909.2 4855.5 4888.1 4910.5 4928.1 4945.5 4519.6 4602.6 4652.1 4730.8 4740.2 5027.4 5034.7 5036.9 5044.0 5092.5 4826.5 4831.1 4831.6 4850.5 4892.3 4751.1 4871.7 4911.0 4957.8 4960.1 4951.4 4953.2 4962.0 4967.3 5019.4 4724.6 4938.4 4945.7 4953.3 5008.4 4110.2 4119.8 4149.0 4230.7 4246.8 3620.4 3651.6 3662.3 3690.6 3697.3 4266.1 4269.5 4274.9 4276.4 4317.5 4876.9 4949.0 4989.5 5032.2 5037.3 4294.9 4303.4 4324.4 4324.5 4363.2 4363.3 4513.8 4521.3 4522.0 4556.7 4466.4 4682.3 4712.8 4716.2 4760.1 4963.4 4972.6 4972.9 4974.2 4989.0 4508.1 4688.0 4693.5 4705.2 4736.1 4872.5 4873.3 4892.9 4937.1 4940.2 4899.6 4931.6 4933.0 4934.3 4981.8 4674.0 4711.5 4802.1 4805.4 4835.8 4834.3 4847.0 4859.2 4859.3 4898.1 4763.5 4766.2 4768.1 4776.5 4804.4 4737.6 4804.6 4873.1 4906.7 4914.6 4816.3 4841.2 4843.7 4850.4 4882.1 04:50:44 INFO - PROCESS | 13541 | 04:50:44 INFO - PROCESS | 13541 | [#1] ext.html Cycles:180 Average:36214.32 Median:32685.25 stddev:55366.07 (169.4%) stddev-sans-first:55456.69 04:50:44 INFO - PROCESS | 13541 | Values: 567.9 590.1 592.6 612.2 613.4 25257.4 31970.0 31997.8 32741.0 32785.0 33526.5 34169.5 34206.5 34220.7 34221.0 7035.5 7406.6 7614.9 7616.7 7618.2 9149.5 9470.0 9487.9 9497.1 9503.9 9483.6 9643.1 9650.9 9656.5 9656.7 9443.5 9552.0 9556.3 9582.3 9582.5 9371.0 9468.7 9487.9 9496.1 9748.1 33463.2 34130.5 34142.1 34150.1 34178.7 2869.8 2871.2 2911.5 3119.3 3728.4 25687.0 26353.1 26481.3 26754.9 27109.2 3425.3 3443.7 3524.4 3539.5 3603.7 186552.0 188182.0 190186.0 190277.0 190774.0 47096.5 47417.0 47517.5 47539.8 47570.0 49569.5 49651.0 49699.8 49787.5 49841.0 10839.5 13703.2 13953.1 13966.4 13980.5 8180.4 8323.4 10027.5 10047.7 10358.3 13844.7 13916.4 14075.5 14104.0 14224.9 5309.9 5382.2 5413.5 5419.1 5533.4 853.1 895.0 897.4 941.2 991.9 24847.8 26664.2 26688.9 26759.7 26778.8 894.2 964.2 974.5 998.2 1072.4 13627.8 14078.3 14138.6 14305.0 14362.6 260819.0 262241.0 264683.0 264686.0 264897.0 44538.8 44735.3 44737.3 44759.3 44811.0 1098.9 1193.9 1227.2 1230.3 1309.5 23893.8 26181.5 27182.2 27189.3 27275.2 36555.3 36967.3 37022.3 37023.6 37031.6 170666.0 171557.0 171836.0 182856.0 183160.1 25879.7 28676.7 30521.5 30820.7 30962.5 33255.0 34204.1 34267.3 34292.3 34327.1 28326.0 29672.0 29965.0 29994.6 30284.2 29767.7 30130.0 31580.2 32174.4 32629.5 29055.6 29650.4 29752.4 29941.4 30072.1 26662.0 27409.6 28846.4 29982.7 30183.5 22841.4 23287.2 23425.3 23445.6 23590.3 04:50:44 INFO - PROCESS | 13541 | 04:50:44 INFO - PROCESS | 13541 | [#2] jquery.html Cycles:180 Average:21857.14 Median:24688.76 stddev:57237.17 (231.8%) stddev-sans-first:57375.02 04:50:44 INFO - PROCESS | 13541 | Values: 379.0 379.8 380.4 382.2 389.1 15003.6 15857.7 16189.6 16200.0 16203.3 14618.2 14843.3 14918.9 14967.9 15007.2 4609.7 4794.2 4798.2 4799.4 4803.4 3586.4 4609.6 5447.4 5752.4 5773.5 5831.0 5835.5 5841.2 5864.1 5866.7 5683.1 5776.5 5837.4 5882.0 5885.2 3325.6 4854.2 5079.6 5111.8 5111.9 18500.5 19215.2 19248.8 19295.3 19333.0 1901.5 1904.7 1994.4 2185.4 2485.9 12157.4 12315.6 12377.4 12752.3 13013.4 1773.4 1816.9 1967.5 1998.4 2005.5 49958.0 51554.2 51604.2 51906.2 52124.7 9389.5 9588.1 9623.7 9717.7 10079.8 13734.8 13742.8 13796.4 13836.8 13848.2 7061.7 7078.3 7127.4 7183.9 7313.7 6860.4 6868.0 6883.7 6973.4 7016.4 4216.8 4369.7 4421.8 4479.1 4489.2 1693.3 1729.2 1813.6 1843.7 1854.8 791.1 833.4 872.0 887.6 899.7 14554.1 14630.3 15480.6 15509.1 15872.4 833.1 839.5 859.7 867.3 927.6 8807.6 8920.6 9133.9 9224.3 9386.0 344681.0 347459.0 349237.0 349325.0 354156.0 63929.0 64787.4 65070.3 65914.3 67283.7 905.7 920.5 931.5 937.9 978.4 14360.4 14988.5 15243.9 15330.8 15418.2 31541.6 32112.5 32485.5 33378.5 33411.3 43736.3 44507.8 44835.6 44888.3 45179.8 7645.8 7708.3 7734.7 7842.9 7919.7 10699.7 11211.9 11223.4 11319.9 11330.6 9594.9 9787.9 9834.5 9994.9 9995.3 9873.7 9946.4 10034.7 10089.4 10175.1 5756.5 6542.0 10144.1 10251.6 10270.9 7490.7 7767.5 7789.0 7854.0 7922.6 9405.2 10020.8 10050.0 10134.2 10349.8 04:50:44 INFO - PROCESS | 13541 | 04:50:44 INFO - PROCESS | 13541 | [#3] mootools.html Cycles:180 Average:4997.84 Median:5088.39 stddev:2774.90 (54.5%) stddev-sans-first:2768.12 04:50:44 INFO - PROCESS | 13541 | Values: 1214.4 1394.8 1432.5 1478.9 1641.4 6424.9 7295.1 7444.1 7470.1 7479.0 7149.5 7308.9 7309.2 7312.1 7316.1 2154.8 2185.4 2188.6 2190.2 2192.7 2130.8 2157.8 2192.8 2192.9 2201.5 2146.5 2165.2 2185.2 2185.6 2188.7 2131.8 2136.3 2138.2 2142.2 2143.8 2113.9 2153.0 2155.9 2163.0 2164.8 7331.3 7400.5 7420.6 7454.4 7460.6 4496.8 4643.5 4649.3 4664.0 4686.1 2877.2 2900.6 2906.1 2944.4 2962.6 882.4 895.6 896.6 913.3 920.2 10127.9 10157.4 10304.7 10312.2 10362.5 4046.2 4065.5 4139.4 4147.1 4218.0 8187.5 8259.9 8276.3 8278.9 8297.5 4535.2 4573.3 4588.7 4590.1 4597.5 3602.7 4159.4 4211.1 4247.8 4342.6 3339.7 3365.6 3401.3 3501.9 3514.6 1051.4 1056.8 1058.9 1065.9 1087.4 674.6 783.5 856.8 872.1 886.9 4787.8 4825.9 5076.6 5080.9 5187.5 840.1 856.3 866.0 892.3 900.1 3291.7 3323.2 3374.6 3393.1 3514.8 8962.3 9354.7 9426.1 9444.7 9446.8 9269.8 9280.2 9343.5 9364.0 9367.3 7257.0 7271.8 7312.0 7383.7 7412.6 4944.3 5045.9 5095.9 5141.5 5194.4 8597.6 8782.4 8827.5 8839.7 9051.8 9079.0 9153.7 9157.0 9216.2 9235.5 6558.3 6643.8 6653.5 6757.8 6797.8 7193.7 7237.5 7299.4 7328.1 7345.2 6464.2 6602.6 6617.4 6678.8 6686.2 6670.3 6700.2 6716.2 6737.9 6787.0 6018.1 6027.2 6045.0 6057.9 6063.0 4386.2 4423.2 4541.8 4552.7 4575.3 4444.1 4494.1 4590.9 4599.2 4620.9 04:50:44 INFO - PROCESS | 13541 | 04:50:44 INFO - PROCESS | 13541 | [#4] prototype.html Cycles:180 Average:4204.83 Median:4715.29 stddev:1230.52 (26.1%) stddev-sans-first:1198.48 04:50:44 INFO - PROCESS | 13541 | Values: 295.9 296.6 298.1 298.2 301.3 4708.4 4713.3 4714.5 4718.3 4746.2 4697.2 4705.0 4716.1 4719.5 4731.8 3554.2 3638.4 3709.9 3743.3 3765.2 3711.7 3732.8 3745.3 3749.4 3764.7 3521.3 3711.2 3716.9 3727.8 3730.5 3592.2 3728.9 3742.2 3748.6 3762.4 3307.7 3325.5 3326.1 3329.6 3340.9 4529.7 4535.5 4539.1 4540.8 4554.0 3950.8 4201.2 4246.2 4277.6 4305.0 4933.3 4948.9 4964.8 4976.5 4982.8 3529.4 3532.5 3539.5 3547.7 3550.0 4951.3 5133.3 5166.6 5214.8 5230.2 3599.2 3612.9 3617.3 3619.9 3625.3 3634.7 3657.8 3669.8 3678.7 3679.6 4176.9 4190.1 4195.6 4196.7 4209.2 4854.8 4988.6 4995.9 5004.8 5009.2 1324.7 1327.2 1327.9 1333.7 1336.4 820.1 874.6 876.4 893.0 894.5 4603.2 4612.9 4625.4 4632.6 4656.9 5410.9 5411.5 5428.4 5437.0 5441.3 4511.8 4602.9 4622.2 4624.9 4642.0 2869.1 2871.1 2886.2 2901.4 2903.7 5132.1 5135.2 5141.5 5142.6 5143.0 5382.5 5520.7 5562.8 5570.9 5591.8 5053.2 5086.4 5086.5 5095.9 5110.7 5413.7 5421.2 5445.3 5466.8 5471.3 4876.2 5117.7 5129.2 5136.5 5141.5 4891.3 4913.4 4936.8 4949.8 4958.2 3653.7 3691.8 3696.4 3700.8 3707.1 5121.4 5155.8 5168.1 5175.8 5187.7 4996.5 5019.0 5019.3 5023.7 5043.8 5016.8 5023.7 5025.2 5041.5 5050.2 4701.7 4723.7 4950.7 4987.6 5006.5 4914.0 4977.0 4977.2 4994.9 5001.7 4937.0 4956.5 4990.3 5008.6 5009.1 04:50:44 INFO - PROCESS | 13541 | 04:50:44 INFO - PROCESS | 13541 | [#5] yui.html Cycles:180 Average:12336.56 Median:43018.68 stddev:13806.43 (32.1%) stddev-sans-first:13817.04 04:50:44 INFO - PROCESS | 13541 | Values: 602.7 734.7 738.6 758.9 763.0 12078.3 12326.4 12333.9 12342.8 12552.3 12023.5 12031.4 12116.2 12116.4 12116.7 636.3 778.1 795.5 800.9 812.5 801.3 804.8 807.3 807.5 809.5 840.3 843.5 843.6 843.8 844.6 664.9 814.1 834.4 839.3 839.3 615.5 615.8 615.9 616.2 616.2 12191.6 12269.6 12317.6 12324.3 12366.1 12141.0 12264.2 12597.9 12685.9 12826.2 7915.2 8134.7 8436.7 8564.6 8803.7 3334.3 3398.0 3413.0 3415.4 3435.5 40376.8 40556.4 42134.0 42240.2 42550.1 9628.5 9974.0 10054.9 10101.9 10216.2 15865.3 15947.3 16002.4 16058.4 16122.3 6379.6 6481.3 6639.0 6641.9 6835.2 3737.4 3738.0 3837.4 3838.5 3845.2 2762.5 2829.8 2882.5 2884.2 2892.8 513.7 525.9 535.3 537.0 538.2 458.2 522.6 537.3 548.9 609.4 7465.8 7569.7 7626.0 7871.4 7881.6 592.8 597.4 607.3 610.2 624.2 3496.2 3576.4 3576.7 3600.3 3633.8 37023.8 37119.0 49561.0 52784.7 54261.2 43533.6 43543.8 43869.8 44024.8 47426.5 42520.0 42983.8 43053.6 43369.6 43743.3 7079.6 7280.5 7295.2 7379.2 7411.6 27200.5 27900.7 28154.0 28517.7 29033.0 40014.8 41512.2 41688.2 41741.2 42531.6 10819.5 10827.6 11095.0 11228.8 11235.1 11487.5 12405.7 12425.3 12527.7 12559.5 10508.4 10670.9 10775.9 10790.2 10794.9 9155.3 9814.8 10033.4 10495.6 10568.0 10420.3 10441.8 10506.5 10691.4 10893.7 9859.4 9881.9 9927.8 9952.0 10413.3 9323.5 9439.5 9535.5 9573.2 9621.5 04:50:44 INFO - PROCESS | 13541 | -------- Summary: end -------- 04:50:44 INFO - PROCESS | 13541 | 04:50:44 INFO - TEST-INFO | 13541: exit 0 04:50:44 INFO - TEST-OK | dromaeo_css | took 1118103ms 04:50:44 INFO - TEST-START | kraken 04:50:44 INFO - operating with platform_type : linux_ 04:50:44 INFO - Initialising browser for kraken test... 04:50:44 INFO - TEST-INFO | started process 13718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIWeeU7/profile http://localhost:50602/getInfo.html) 04:50:49 INFO - PROCESS | 13718 | __metrics Screen width/height:1600/1200 04:50:49 INFO - PROCESS | 13718 | colorDepth:24 04:50:49 INFO - PROCESS | 13718 | Browser inner width/height: 1024/697 04:50:49 INFO - PROCESS | 13718 | __metrics 04:50:50 ERROR - PROCESS | 13718 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:50:51 INFO - TEST-INFO | 13718: exit 0 04:50:51 INFO - Browser initialized. 04:50:51 INFO - Running cycle 1/1 for kraken test... 04:50:51 INFO - TEST-INFO | started process 13798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIWeeU7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:03 INFO - PROCESS | 13798 | RSS: Main: 156438528 04:51:03 INFO - PROCESS | 13798 | 04:51:05 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50602/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:06 INFO - PROCESS | 13798 | RSS: Main: 210743296 04:51:06 INFO - PROCESS | 13798 | 04:51:09 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50602/tests/kraken/driver.html?testName=audio-dft) 04:51:10 INFO - PROCESS | 13798 | RSS: Main: 196206592 04:51:10 INFO - PROCESS | 13798 | 04:51:13 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50602/tests/kraken/driver.html?testName=audio-fft) 04:51:14 INFO - PROCESS | 13798 | RSS: Main: 267452416 04:51:14 INFO - PROCESS | 13798 | 04:51:16 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50602/tests/kraken/driver.html?testName=audio-oscillator) 04:51:16 INFO - PROCESS | 13798 | RSS: Main: 174948352 04:51:16 INFO - PROCESS | 13798 | 04:51:19 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50602/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:19 INFO - PROCESS | 13798 | RSS: Main: 178991104 04:51:19 INFO - PROCESS | 13798 | 04:51:22 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50602/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:23 INFO - PROCESS | 13798 | RSS: Main: 215764992 04:51:23 INFO - PROCESS | 13798 | 04:51:26 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50602/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:27 INFO - PROCESS | 13798 | RSS: Main: 213823488 04:51:27 INFO - PROCESS | 13798 | 04:51:30 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50602/tests/kraken/driver.html?testName=json-parse-financial) 04:51:30 INFO - PROCESS | 13798 | RSS: Main: 215339008 04:51:30 INFO - PROCESS | 13798 | 04:51:32 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50602/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:33 INFO - PROCESS | 13798 | RSS: Main: 201846784 04:51:33 INFO - PROCESS | 13798 | 04:51:35 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50602/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:35 INFO - PROCESS | 13798 | RSS: Main: 204894208 04:51:35 INFO - PROCESS | 13798 | 04:51:37 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50602/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:38 INFO - PROCESS | 13798 | RSS: Main: 215953408 04:51:38 INFO - PROCESS | 13798 | 04:51:41 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:41 INFO - PROCESS | 13798 | RSS: Main: 224579584 04:51:41 INFO - PROCESS | 13798 | 04:51:45 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:46 INFO - PROCESS | 13798 | RSS: Main: 222416896 04:51:46 INFO - PROCESS | 13798 | 04:51:47 INFO - PROCESS | 13798 | Cycle 1(1): loaded http://localhost:50602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50602/tests/kraken/driver.html?testName=ai-astar) 04:51:48 INFO - PROCESS | 13798 | RSS: Main: 285655040 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | __start_tp_report 04:51:48 INFO - PROCESS | 13798 | _x_x_mozilla_page_load 04:51:48 INFO - PROCESS | 13798 | _x_x_mozilla_page_load_details 04:51:48 INFO - PROCESS | 13798 | |i|pagename|runs| 04:51:48 INFO - PROCESS | 13798 | |0;ai-astar;113;113;109;113;113;113;102;113;114;113 04:51:48 INFO - PROCESS | 13798 | |1;audio-beat-detection;170;133;158;176;133;159;156;139;192;138 04:51:48 INFO - PROCESS | 13798 | |2;audio-dft;161;160;162;161;161;161;163;161;161;161 04:51:48 INFO - PROCESS | 13798 | |3;audio-fft;74;78;111;101;75;74;74;112;99;86 04:51:48 INFO - PROCESS | 13798 | |4;audio-oscillator;96;99;148;95;95;95;147;94;94;153 04:51:48 INFO - PROCESS | 13798 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 04:51:48 INFO - PROCESS | 13798 | |6;imaging-darkroom;146;147;146;146;146;147;146;146;146;145 04:51:48 INFO - PROCESS | 13798 | |7;imaging-desaturate;95;95;94;96;94;94;95;95;95;95 04:51:48 INFO - PROCESS | 13798 | |8;json-parse-financial;68;67;69;66;68;67;67;83;65;65 04:51:48 INFO - PROCESS | 13798 | |9;json-stringify-tinderbox;66;65;64;65;64;65;65;66;65;66 04:51:48 INFO - PROCESS | 13798 | |10;stanford-crypto-aes;86;80;80;79;80;89;85;79;80;79 04:51:48 INFO - PROCESS | 13798 | |11;stanford-crypto-ccm;147;136;134;137;137;137;133;133;180;135 04:51:48 INFO - PROCESS | 13798 | |12;stanford-crypto-pbkdf2;217;224;219;228;228;221;215;218;226;220 04:51:48 INFO - PROCESS | 13798 | |13;stanford-crypto-sha256-iterative;77;77;75;77;76;77;76;74;74;74 04:51:48 INFO - PROCESS | 13798 | __end_tp_report 04:51:48 INFO - PROCESS | 13798 | __start_cc_report 04:51:48 INFO - PROCESS | 13798 | _x_x_mozilla_cycle_collect,1904 04:51:48 INFO - PROCESS | 13798 | __end_cc_report 04:51:48 INFO - PROCESS | 13798 | __startTimestamp1461757908111__endTimestamp 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | ------- Summary: start ------- 04:51:48 INFO - PROCESS | 13798 | Number of tests: 14 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.63 (3.2%) stddev-sans-first:3.81 04:51:48 INFO - PROCESS | 13798 | Values: 113.0 113.0 109.0 113.0 113.0 113.0 102.0 113.0 114.0 113.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:158.50 stddev:19.92 (12.6%) stddev-sans-first:20.42 04:51:48 INFO - PROCESS | 13798 | Values: 170.0 133.0 158.0 176.0 133.0 159.0 156.0 139.0 192.0 138.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 04:51:48 INFO - PROCESS | 13798 | Values: 161.0 160.0 162.0 161.0 161.0 161.0 163.0 161.0 161.0 161.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#3] audio-fft Cycles:10 Average:88.40 Median:74.50 stddev:15.83 (21.2%) stddev-sans-first:15.91 04:51:48 INFO - PROCESS | 13798 | Values: 74.0 78.0 111.0 101.0 75.0 74.0 74.0 112.0 99.0 86.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:95.00 stddev:26.12 (27.5%) stddev-sans-first:27.09 04:51:48 INFO - PROCESS | 13798 | Values: 96.0 99.0 148.0 95.0 95.0 95.0 147.0 94.0 94.0 153.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:51:48 INFO - PROCESS | 13798 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:51:48 INFO - PROCESS | 13798 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:51:48 INFO - PROCESS | 13798 | Values: 95.0 95.0 94.0 96.0 94.0 94.0 95.0 95.0 95.0 95.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:67.50 stddev:5.25 (7.8%) stddev-sans-first:5.57 04:51:48 INFO - PROCESS | 13798 | Values: 68.0 67.0 69.0 66.0 68.0 67.0 67.0 83.0 65.0 65.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 04:51:48 INFO - PROCESS | 13798 | Values: 66.0 65.0 64.0 65.0 64.0 65.0 65.0 66.0 65.0 66.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:80.00 stddev:3.59 (4.5%) stddev-sans-first:3.46 04:51:48 INFO - PROCESS | 13798 | Values: 86.0 80.0 80.0 79.0 80.0 89.0 85.0 79.0 80.0 79.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:137.00 stddev:14.31 (10.4%) stddev-sans-first:15.01 04:51:48 INFO - PROCESS | 13798 | Values: 147.0 136.0 134.0 137.0 137.0 137.0 133.0 133.0 180.0 135.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:221.60 Median:222.50 stddev:4.65 (2.1%) stddev-sans-first:4.62 04:51:48 INFO - PROCESS | 13798 | Values: 217.0 224.0 219.0 228.0 228.0 221.0 215.0 218.0 226.0 220.0 04:51:48 INFO - PROCESS | 13798 | 04:51:48 INFO - PROCESS | 13798 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:76.50 stddev:1.34 (1.7%) stddev-sans-first:1.33 04:51:48 INFO - PROCESS | 13798 | Values: 77.0 77.0 75.0 77.0 76.0 77.0 76.0 74.0 74.0 74.0 04:51:48 INFO - PROCESS | 13798 | -------- Summary: end -------- 04:51:48 INFO - PROCESS | 13798 | 04:51:49 INFO - TEST-INFO | 13798: exit 0 04:51:49 INFO - TEST-OK | kraken | took 64305ms 04:51:49 INFO - SUITE-END | took 1182s 04:51:49 INFO - Completed test suite (00:19:42) 04:51:49 INFO - javascript benchmark 04:51:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2588.585826267797, 2662.0150544298626, 2666.3867310518594, 2679.303381120908, 2695.9865200674, 4505.909881802362, 4593.242115051021, 4666.883327916799, 4673.813047478101, 4691.179043667362, 4631.8147274109, 4652.627789776819, 4657.394538709963, 4679.251319788835, 4704.670673052888, 4191.916161676764, 4200.1179752252065, 4218.472690913643, 4264.296391095481, 4376.212281789277, 4334.0, 4352.107817897339, 4360.302351623741, 4403.207422663919, 4412.426384570002, 4135.669146468305, 4212.304969679999, 4244.342126970325, 4250.298700714409, 4311.00846805235, 4233.745975241495, 4266.0, 4272.124214536044, 4273.764942928137, 4313.223619748444, 4237.194932962727, 4250.404943307939, 4264.957350426487, 4265.232258193524, 4305.009847735038, 4353.891152721208, 4479.977600112011, 4536.591706746409, 4540.18276710192, 4560.543945605446, 4861.9027619447415, 4882.853514394538, 4892.755362231874, 4895.11887860185, 4909.189983652693, 4855.514448555152, 4888.144574699449, 4910.533499317559, 4928.137575924235, 4945.455999840015, 4519.638428925645, 4602.585767280927, 4652.13935421948, 4730.810767569327, 4740.19416699162, 5027.4218464877, 5034.723090230073, 5036.874078148076, 5043.99120175959, 5092.490750924878, 4826.469088400273, 4831.0820944020525, 4831.589314908202, 4850.490698476679, 4892.315075889378, 4751.097291514601, 4871.707697538159, 4911.0, 4957.752112394366, 4960.057589058068, 4951.356323677899, 4953.182724850431, 4962.0, 4967.2549117631925, 5019.447860735316, 4724.574788269072, 4938.38270216223, 4945.703257804544, 4953.25701144824, 5008.449070602231, 4110.219058378899, 4119.8352065917625, 4148.979255103765, 4230.703850730481, 4246.766427846498, 3620.3664358737115, 3651.561812582454, 3662.2675464907124, 3690.5755838078962, 3697.2975134724315, 4266.0827921996915, 4269.509006464296, 4274.935875961863, 4276.444062271885, 4317.481902171759, 4876.902461950741, 4949.0, 4989.476105008995, 5032.194848824171, 5037.345145131109, 4294.892627684333, 4303.376010478463, 4324.416203812445, 4324.545922678073, 4363.192809330284, 4363.323684828857, 4513.842015529441, 4521.299198624219, 4521.977390113028, 4556.703814252063, 4466.441694788216, 4682.344471773954, 4712.764361781966, 4716.221823399238, 4760.071786001697, 4963.429205641253, 4972.552470277692, 4972.925406118983, 4974.228994505857, 4988.975055124846, 4508.120916421266, 4687.953120468752, 4693.483716791218, 4705.176594095951, 4736.076465089274, 4872.537108974641, 4873.293372461044, 4892.8532144035735, 4937.061958227925, 4940.209566469348, 4899.608031357411, 4931.580815630568, 4932.988173796816, 4934.284528743384, 4981.825636102719, 4674.0, 4711.481737008995, 4802.063597598435, 4805.423349198119, 4835.758212089452, 4834.274858771212, 4847.0, 4859.246816743411, 4859.343988561499, 4898.118338699069, 4763.523647635208, 4766.213574760126, 4768.1417344878255, 4776.522347765334, 4804.351412559399, 4737.620990320835, 4804.567588917014, 4873.074115917964, 4906.730129842893, 4914.606831453403, 4816.34979277807, 4841.176999910094, 4843.685160464699, 4850.369451971221, 4882.145624515624], "value": 4550.171707362195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.9488846003859, 590.1266126133322, 592.6118392452942, 612.2408213814865, 613.3651670521009, 25257.36856578584, 31970.0, 31997.840010799944, 32741.0, 32785.0, 33526.49710254348, 34169.487457688156, 34206.486902696415, 34220.657793422055, 34221.0, 7035.472339574552, 7406.592637404954, 7614.923850761477, 7616.695332186706, 7618.200088990659, 9149.542522873862, 9469.952650236739, 9487.905120948772, 9497.145256926875, 9503.857442138373, 9483.62065517382, 9643.083907028857, 9650.855237171449, 9656.468894210815, 9656.662016829412, 9443.527823608827, 9552.044795520462, 9556.283278754121, 9582.329236953416, 9582.472963986978, 9371.0, 9468.668596599155, 9487.905120948772, 9496.145346918742, 9748.073932976356, 33463.163420914425, 34130.48804267938, 34142.14644633879, 34150.14624634379, 34178.65821341804, 2869.7991140620165, 2871.181713211725, 2911.5195992661183, 3119.298157914474, 3728.440733889911, 25687.0, 26353.07764228262, 26481.337966550796, 26754.866225668746, 27109.186724398103, 3425.2635683327953, 3443.724502039831, 3524.400851855191, 3539.522164507784, 3603.657652523006, 186552.0, 188182.0, 190186.0, 190277.04861475743, 190774.0, 47096.5290347099, 47417.0, 47517.524824752, 47539.76230118897, 47570.0, 49569.50430495721, 49651.0, 49699.75150124299, 49787.50212497901, 49841.0, 10839.512221950032, 13703.177809331472, 13953.093048951785, 13966.441342346396, 13980.51068212628, 8180.386471014698, 8323.375746819012, 10027.548760305805, 10047.748806279902, 10358.274920755475, 13844.653883652989, 13916.443342266197, 14075.507357242448, 14104.0, 14224.85775142256, 5309.893802124013, 5382.192671099288, 5413.458654134633, 5419.132938729863, 5533.418991005967, 853.0957185383513, 894.9776255593532, 897.434616191795, 941.1905761045496, 991.8809742830762, 24847.751522484905, 26664.20007399781, 26688.866555667097, 26759.732402675723, 26778.794954226716, 894.2041582991143, 964.1749673456699, 974.4786539201493, 998.1515711645188, 1072.3673032910465, 13627.795583066261, 14078.2960851957, 14138.64653383653, 14304.998650094394, 14362.569122926328, 260819.0, 262241.0, 264683.0, 264686.0, 264897.0, 44538.77730611326, 44735.32897006548, 44737.32894006593, 44759.32861007087, 44811.0, 1098.8846171152074, 1193.8567371915426, 1227.2391117507202, 1230.2802860326808, 1309.4762095162012, 23893.805309734096, 26181.476370472104, 27182.184534464, 27189.320266993484, 27275.181744547695, 36555.26889462249, 36967.26065478729, 37022.259554809294, 37023.629763703095, 37031.62968370282, 170666.0, 171557.0, 171836.0, 182856.0, 183160.08419957815, 25879.741202588488, 28676.713232867405, 30521.542176866922, 30820.691793081784, 30962.53556196614, 33254.96602976606, 34204.14489637779, 34267.314653706286, 34292.314153717285, 34327.141821454665, 28326.0, 29672.0, 29965.0, 29994.550081748355, 30284.24289392783, 29767.702322976493, 30130.0, 31580.210494737814, 32174.356512869144, 32629.495216100906, 29055.56416653794, 29650.406991860473, 29752.404951901273, 29941.401171976875, 30072.097837064925, 26662.0, 27409.588856166774, 28846.423071538873, 29982.70017299799, 30183.547246791753, 22841.42896427536, 23287.1849485274, 23425.297241082793, 23445.648315274942, 23590.29229123129], "value": 16032.594478589754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.95263092113487, 379.83287353564447, 380.3894748927971, 382.2469734622793, 389.07012240744626, 15003.624909377257, 15857.682846343081, 16189.595260118473, 16200.0, 16203.270852811607, 14618.195999220039, 14843.332050057747, 14918.85081149191, 14967.925160374183, 15007.174605396698, 4609.7003694759815, 4794.184988551954, 4798.184308667535, 4799.448063472711, 4803.423589169304, 3586.372384832644, 4609.631229501649, 5447.400785913546, 5752.36723960364, 5773.509251713609, 5831.037878750001, 5835.474807267345, 5841.240638716961, 5864.091065884794, 5866.706664666771, 5683.090705487102, 5776.5089967352615, 5837.357890632027, 5881.970590147064, 5885.234919460464, 3325.584301962255, 4854.150523658345, 5079.644424890259, 5111.795528178868, 5111.897762044776, 18500.537486562807, 19215.231390744353, 19248.807511924842, 19295.324663636704, 19333.0, 1901.496103532565, 1904.6762050451457, 1994.3518356534184, 2185.4208634711813, 2485.8881350339097, 12157.392130393533, 12315.630531084082, 12377.443015064344, 12752.2986235757, 13013.414396352187, 1773.3704534890057, 1816.9091545422675, 1967.5376286572643, 1998.4204580671587, 2005.5387260929922, 49958.0, 51554.22668659973, 51604.22593661098, 51906.22140667893, 52124.73937630325, 9389.530523473935, 9588.137067663803, 9623.663171788954, 9717.6598819041, 10079.848802267972, 13734.793978090336, 13742.793858092136, 13796.379162937692, 13836.792448113287, 13848.169109853441, 7061.717531298793, 7078.292170782984, 7127.358537731526, 7183.92816071843, 7313.707451701979, 6860.416864566568, 6868.012414599665, 6883.65581720912, 6973.372396484239, 7016.36852683261, 4216.789160541961, 4369.71596846204, 4421.756803375781, 4479.081788233404, 4489.191945449785, 1693.3226709316125, 1729.1959238953946, 1813.6282062177222, 1843.695790194603, 1854.7774267087766, 791.1455627921831, 833.3624777045565, 871.9738407847775, 887.6316328723508, 899.7120921305119, 14554.053986490844, 14630.26848657563, 15480.612984675248, 15509.069455832687, 15872.44446444369, 833.0960907415401, 839.5172775653901, 859.6991053131354, 867.3408209760502, 927.6150397584927, 8807.559622019002, 8920.643174272956, 9133.862992055125, 9224.30817688676, 9386.0, 344681.0, 347459.0, 349237.0, 349325.0, 354156.0, 63929.0, 64787.35212647813, 65070.349296507375, 65914.34085659082, 67283.66358168177, 905.6558507767138, 920.5351297594672, 931.4737173496952, 937.9108984646448, 978.3640633588225, 14360.44507287164, 14988.47540336083, 15243.923780381027, 15330.846691532943, 15418.152001640017, 31541.59075594581, 32112.518312225802, 32485.512717308786, 33378.49932251067, 33411.33177336391, 43736.343954840064, 44507.777461112484, 44835.55164448314, 44888.32667510055, 45179.77410112928, 7645.770626881203, 7708.267714567107, 7734.690612375442, 7842.882356764539, 7919.683212671659, 10699.732506687395, 11211.88788112141, 11223.4388280584, 11319.943400282946, 11330.60342887995, 9594.856077158987, 9787.902120978984, 9834.508274586098, 9994.900050999688, 9995.300328976902, 9873.703788886345, 9946.35348702332, 10034.69895903124, 10089.445080520349, 10175.135113515138, 5756.539476841926, 6542.0, 10144.137748291183, 10251.641192558225, 10270.948645256725, 7490.662920168496, 7767.495112817649, 7788.9610551949145, 7854.0, 7922.603869806602, 9405.153536181777, 10020.799584008424, 10050.0, 10134.23993200498, 10349.824465304067], "value": 7936.188257674587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1214.3624597086523, 1394.7768357062869, 1432.520105764569, 1478.9334479948402, 1641.3516660918938, 6424.903626445607, 7295.124585049794, 7444.10670719513, 7470.140933792615, 7478.96260518698, 7149.463790215728, 7308.890366644505, 7309.232530584291, 7312.085989251344, 7316.122065352152, 2154.8168405685537, 2185.3771675072608, 2188.5732282204976, 2190.200576789476, 2192.6710993350966, 2130.7869213078648, 2157.7626461089267, 2192.7807219278025, 2192.8684278943233, 2201.515666553356, 2146.527763891941, 2165.231342873281, 2185.158713895154, 2185.5956648020087, 2188.7482939462006, 2131.765505794361, 2136.2950226425396, 2138.230237114645, 2142.1966762464076, 2143.7856214378517, 2113.8625989310644, 2152.9892350538303, 2155.9245426410002, 2162.967555486669, 2164.7618761936333, 7331.303526165006, 7400.481966262364, 7420.5547667140145, 7454.366378857803, 7460.589667568282, 4496.842610508616, 4643.512431194744, 4649.279361698942, 4663.953360466419, 4686.062787442525, 2877.2375320540073, 2900.5939168516425, 2906.099109276131, 2944.4258369617933, 2962.614860068199, 882.4220135811054, 895.5746020640208, 896.6054935828215, 913.2602591900582, 920.2040235196574, 10127.898721012769, 10157.441340726331, 10304.742381440448, 10312.226583006304, 10362.533685984074, 4046.2312160689376, 4065.4511640928686, 4139.441175441337, 4147.066909945299, 4218.029853133735, 8187.549684767276, 8259.876101858477, 8276.255137037575, 8278.875816862752, 8297.543635100128, 4535.229011068126, 4573.291139873325, 4588.7246765194195, 4590.104929538775, 4597.540245975376, 3602.7117830573493, 4159.355299928456, 4211.115665710236, 4247.787610619456, 4342.609165175149, 3339.749518786101, 3365.5793025871767, 3401.3027329397414, 3501.9474707879403, 3514.578250609943, 1051.4427353502656, 1056.7622284985816, 1058.8888166742536, 1065.8880817514205, 1087.423665457309, 674.6289540752566, 783.5494590610308, 856.7943693513637, 872.1365847810748, 886.8581027035773, 4787.832425865078, 4825.9034819303415, 5076.568491678175, 5080.898382032413, 5187.507186817246, 840.0926998841237, 856.2764464027887, 865.9824705970459, 892.3084609427616, 900.0504467786417, 3291.687289707474, 3323.152596087982, 3374.5950485941844, 3393.1347506385714, 3514.7715398499017, 8962.32782541312, 9354.672586459441, 9426.104520070583, 9444.716658500256, 9446.811063778687, 9269.814603707888, 9280.211182049467, 9343.486108263975, 9364.0, 9367.297452691075, 7256.96371518139, 7271.818204544823, 7311.963440182765, 7383.6677349519405, 7412.629368531552, 4944.283078953604, 5045.949540504548, 5095.87260318495, 5141.53726164647, 5194.402643696023, 8597.613107410307, 8782.385233033627, 8827.470351778913, 8839.734807955772, 9051.818963620559, 9079.0, 9153.725388238363, 9157.0, 9216.170544651013, 9235.492047937429, 6558.311377305315, 6643.833904152435, 6653.534252602465, 6757.763478278237, 6797.796066118024, 7193.676284567103, 7237.529560578546, 7299.379552738077, 7328.120625524758, 7345.155307139534, 6464.191976003, 6602.570832896038, 6617.404433600999, 6678.766243181465, 6686.197656281277, 6670.299618539983, 6700.229473610597, 6716.1604799400075, 6737.898931515933, 6787.0, 6018.067199584071, 6027.156198132353, 6044.969775151272, 6057.939420605738, 6063.029915213545, 4386.166628340605, 4423.181711383404, 4541.772911354486, 4552.704074235164, 4575.313702944585, 4444.1333939881415, 4494.078713863585, 4590.931136033029, 4599.1721490132095, 4620.884477888079], "value": 4035.593390940017, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.8698172803966, 296.61143901489044, 298.10568295114655, 298.23205246490295, 301.3385618567245, 4708.36437080994, 4713.269443236295, 4714.457837348702, 4718.268668356411, 4746.193147164981, 4697.224957881946, 4705.035467729116, 4716.127516409467, 4719.50445203253, 4731.763411829404, 3554.1825380162513, 3638.381475149231, 3709.8516059357594, 3743.28877513273, 3765.213741831039, 3711.6659500644937, 3732.7760334379886, 3745.2509498100353, 3749.362608356586, 3764.7246895201215, 3521.295740851827, 3711.2206436648203, 3716.869909553166, 3727.7949712765785, 3730.5336832895887, 3592.1558433768173, 3728.925421491555, 3742.1954279829965, 3748.643878831534, 3762.3792074307707, 3307.7023067924, 3325.451300535433, 3326.1185785766793, 3329.5505106810756, 3340.9331813363597, 4529.728216307032, 4535.478419981711, 4539.137563862855, 4540.842085268268, 4553.977230113861, 3950.8222130003933, 4201.243776120297, 4246.214450326699, 4277.615014648665, 4304.956950430487, 4933.309336692866, 4948.87627809304, 4964.826231081931, 4976.527229913152, 4982.800687972477, 3529.400001999666, 3532.540769699948, 3539.486774417695, 3547.6807087362004, 3549.964500354989, 4951.257311403282, 5133.307003554547, 5166.560842328407, 5214.8174813881715, 5230.163173892197, 3599.1541987632886, 3612.8916132516065, 3617.330793803155, 3619.873304434385, 3625.3474374612824, 3634.672879440863, 3657.798821064867, 3669.7614655047337, 3678.70570354371, 3679.576848662438, 4176.851365874409, 4190.099128687347, 4195.643370313496, 4196.685248606367, 4209.158168366339, 4854.80580776765, 4988.575971042502, 4995.900081998412, 5004.84985450437, 5009.223570346602, 1324.6754545136503, 1327.1638867513404, 1327.9070465067352, 1333.6599167212298, 1336.432016393029, 820.122468958209, 874.5845723281518, 876.3777717820419, 892.9687460938836, 894.4677916639589, 4603.240465323252, 4612.86161415158, 4625.444946606429, 4632.583067523871, 4656.859069527987, 5410.8917821643345, 5411.458854114557, 5428.398622406399, 5436.972815135899, 5441.2654291670115, 4511.796969136397, 4602.930956035662, 4622.19111655459, 4624.907501850012, 4641.978764671767, 2869.1249169003236, 2871.0812539987005, 2886.1918662774456, 2901.448724742292, 2903.7386635202934, 5132.050570644443, 5135.15269980449, 5141.53726164647, 5142.61430392722, 5142.97428512855, 5382.542483888835, 5520.702634880799, 5562.833115006556, 5570.860728481739, 5591.776328946797, 5053.2420136979745, 5086.364204474441, 5086.4659210783075, 5095.87260318495, 5110.6678065926335, 5413.702246376487, 5421.241026256406, 5445.292112025411, 5466.797304592983, 5471.343438787371, 4876.244182151772, 5117.692938423706, 5129.153689641316, 5136.481510165549, 5141.53726164647, 4891.339669144762, 4913.361263035782, 4936.802527898987, 4949.82675606352, 4958.231474121517, 3653.7442379033214, 3691.7969511677115, 3696.4085746280466, 3700.7594506358078, 3707.1102935295876, 5121.359830021247, 5155.819546315861, 5168.147255702917, 5175.81884634051, 5187.688738675692, 4996.525330093636, 5019.0, 5019.347484826949, 5023.723695196653, 5043.84868453947, 5016.799328026838, 5023.7488125592845, 5025.1959686451455, 5041.46235398207, 5050.217216331474, 4701.670883038155, 4723.716577005391, 4950.6782059166035, 4987.625928055338, 5006.549410552922, 4913.975430122827, 4976.979719157636, 4977.228529577921, 4994.850154495371, 5001.699898006132, 4937.0, 4956.454789973172, 4990.301357809982, 5008.649394542347, 5009.123403404316], "value": 3816.958514240914, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.710698864545, 734.7244783206297, 738.5679377564123, 758.9279018493241, 762.9694812207508, 12078.335691536962, 12326.445309961051, 12333.876661233397, 12342.753144937096, 12552.309622970733, 12023.51905923762, 12031.398430078505, 12116.151869369147, 12116.394180290972, 12116.69708257294, 636.2841802971657, 778.0818634011864, 795.49883573349, 800.9359251259914, 812.4556547113418, 801.282851847596, 804.7666176808718, 807.2694211738357, 807.5033854179696, 809.5345176523493, 840.277361469136, 843.5149788871393, 843.5824266987819, 843.8185790055137, 844.6452489954233, 664.8803215421223, 814.1370147643516, 834.3700506117902, 839.3201506779528, 839.3369238301734, 615.4952938590358, 615.806021103351, 615.8614311779813, 616.1558664629441, 616.2266355723583, 12191.573294934635, 12269.57056503027, 12317.568885088978, 12324.32216228107, 12366.134370594062, 12140.968017718504, 12264.202826816228, 12597.867254826588, 12685.873141268561, 12826.166299190523, 7915.248051435105, 8134.6746130154725, 8436.662533498653, 8564.61459234336, 8803.691870784492, 3334.333133373311, 3398.048546406985, 3412.9829350853333, 3415.3852306584804, 3435.4503279475416, 40376.79811600952, 40556.39165412521, 42134.0, 42240.155196896194, 42550.148997020195, 9628.518574071268, 9973.950130249448, 10054.949725251327, 10101.94949025265, 10216.182705383551, 15865.286062127232, 15947.282372293275, 16002.439914603166, 16058.357665693475, 16122.274497647633, 6379.617222966637, 6481.254900393984, 6638.96680516604, 6641.900371494431, 6835.213950395669, 3737.4020156774786, 3737.9813100934866, 3837.424386342071, 3838.481804956295, 3845.2117315950163, 2762.5441802102428, 2829.8019138660507, 2882.524383476703, 2884.1780092673907, 2892.783041271913, 513.6969188178992, 525.9421463638996, 535.3094508084528, 537.0252990821646, 538.1927109335996, 458.191292368969, 522.5845452864982, 537.2666310486236, 548.8638518267228, 609.4180058044557, 7465.776026719207, 7569.659365328574, 7626.0, 7871.370290376756, 7881.645325960231, 592.8399332180287, 597.4413922981939, 607.2864384348374, 610.206731249374, 624.1511544299749, 3496.2133519957806, 3576.3741345264993, 3576.678098971105, 3600.261946301002, 3633.818309084535, 37023.81488092542, 37119.0, 49561.0, 52784.73607632014, 54261.1860822088, 43533.56466435359, 43543.782281088395, 43869.78065109718, 44024.779876100416, 47426.5257347429, 42520.0, 42983.78508107439, 43053.56946430558, 43369.57880264904, 43743.34384984228, 7079.575225486487, 7280.526765760421, 7295.2340004298785, 7379.151397589346, 7411.62941852916, 27200.455990880466, 27900.720992790626, 28154.0, 28517.714822851507, 29033.0, 40014.799926001346, 41512.1697566041, 41688.1662366757, 41741.1651766969, 42531.574684253996, 10819.513121909376, 10827.621033263798, 11095.0, 11228.831567526331, 11235.06371163654, 11487.54049837997, 12405.689857753629, 12425.316607586308, 12527.749445010866, 12559.497620095093, 10508.42203678805, 10670.893291067301, 10775.892241077489, 10790.244682872124, 10794.892051079703, 9155.323699306473, 9814.803703926023, 10033.397996120257, 10495.580176792842, 10568.0, 10420.270581059556, 10441.791164176522, 10506.474676266003, 10691.358518488916, 10893.727656808644, 9859.408435493893, 9881.901180988098, 9927.751806204902, 9952.0, 10413.323133996266, 9323.533823308671, 9439.480828554495, 9535.47554884488, 9573.18627916635, 9621.470819105016], "value": 5797.587952288013, "unit": "score"}], "name": "dromaeo_css", "value": 6103.7077243574, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 109.0, 113.0, 113.0, 113.0, 102.0, 113.0, 114.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 133.0, 158.0, 176.0, 133.0, 159.0, 156.0, 139.0, 192.0, 138.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 161.0, 161.0, 163.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 111.0, 101.0, 75.0, 74.0, 74.0, 112.0, 99.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 148.0, 95.0, 95.0, 95.0, 147.0, 94.0, 94.0, 153.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 66.0, 68.0, 67.0, 67.0, 83.0, 65.0, 65.0], "value": 68.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 80.0, 79.0, 80.0, 89.0, 85.0, 79.0, 80.0, 79.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 136.0, 134.0, 137.0, 137.0, 137.0, 133.0, 133.0, 180.0, 135.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 224.0, 219.0, 228.0, 228.0, 221.0, 215.0, 218.0, 226.0, 220.0], "value": 221.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 77.0, 76.0, 77.0, 76.0, 74.0, 74.0, 74.0], "value": 75.7, "unit": "score"}], "name": "kraken", "value": 1639.5, "alertThreshold": 2.0}]} 04:51:49 INFO - Return code: 0 04:51:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:51:49 ERROR - # TBPL SUCCESS # 04:51:49 INFO - Running post-action listener: _resource_record_post_action 04:51:49 INFO - Running post-run listener: _resource_record_post_run 04:51:50 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525295616; Read time: 12; Write time: 489312 04:51:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242008064; Read time: 0; Write time: 266408 04:51:50 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281632768; Read time: 12; Write time: 222884 04:51:50 INFO - Running post-run listener: _upload_blobber_files 04:51:50 INFO - Blob upload gear active. 04:51:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:51:50 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:50 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:51 INFO - (blobuploader) - INFO - Done attempting. 04:51:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:52 INFO - (blobuploader) - INFO - Done attempting. 04:51:52 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:52 INFO - Return code: 0 04:51:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c9e54e91995a9b9eec06e943924c6d04dcfca0aed4fba4cbdee6facc18cce2d00d7a27da046d033be2cb7b23d64465a4e587da28637ee0d484edc569f70f961", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8efac0f7ec22e2c0ea5361f1ee8737ca46ff9e9f89d57880fd6821f6252f26f8736ebdf2beb8328fd8c705a3663b8325b4cc7b153c1a7f334fe69fc50c7fa790"} 04:51:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:52 INFO - Contents: 04:51:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c9e54e91995a9b9eec06e943924c6d04dcfca0aed4fba4cbdee6facc18cce2d00d7a27da046d033be2cb7b23d64465a4e587da28637ee0d484edc569f70f961", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8efac0f7ec22e2c0ea5361f1ee8737ca46ff9e9f89d57880fd6821f6252f26f8736ebdf2beb8328fd8c705a3663b8325b4cc7b153c1a7f334fe69fc50c7fa790"} 04:51:52 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:52 INFO - Copying logs to upload dir... 04:51:52 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.176391 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-27 04:51:51.781409) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:51:51.785071) ========= 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=7de08804244eb36560b44971000001c3-1461756673.468384-2022228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c9e54e91995a9b9eec06e943924c6d04dcfca0aed4fba4cbdee6facc18cce2d00d7a27da046d033be2cb7b23d64465a4e587da28637ee0d484edc569f70f961", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8efac0f7ec22e2c0ea5361f1ee8737ca46ff9e9f89d57880fd6821f6252f26f8736ebdf2beb8328fd8c705a3663b8325b4cc7b153c1a7f334fe69fc50c7fa790"} build_url:https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/RsZhMrEDSbqvuE8XqQnoYg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3c9e54e91995a9b9eec06e943924c6d04dcfca0aed4fba4cbdee6facc18cce2d00d7a27da046d033be2cb7b23d64465a4e587da28637ee0d484edc569f70f961", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8efac0f7ec22e2c0ea5361f1ee8737ca46ff9e9f89d57880fd6821f6252f26f8736ebdf2beb8328fd8c705a3663b8325b4cc7b153c1a7f334fe69fc50c7fa790"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:51:51.813472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:51:51.813833) ========= 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=7de08804244eb36560b44971000001c3-1461756673.468384-2022228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:51:51.899612) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:51:51.899952) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:51:51.900271) ========= ========= Total master_lag: 0.18 =========