builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1461756390.7 results: success (0) buildid: 20160427025907 builduid: 946947c12dd542b49bd94d42b335f8ba revision: ab0044bfa1df858919797bcd6a9aef76a668cd4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:30.697188) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:30.697652) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:30.697938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:30.714967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:30.715314) ========= 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=cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 04:26:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.1M=0s 2016-04-27 04:26:30 (89.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088499 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:30.817271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:30.817599) ========= 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=cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017910 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:30.869151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:30.869757) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ab0044bfa1df858919797bcd6a9aef76a668cd4a --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 ab0044bfa1df858919797bcd6a9aef76a668cd4a --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=cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 04:26:30,986 truncating revision to first 12 chars 2016-04-27 04:26:30,986 Setting DEBUG logging. 2016-04-27 04:26:30,986 attempt 1/10 2016-04-27 04:26:30,987 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ab0044bfa1df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 04:26:31,330 unpacking tar archive at: mozilla-central-ab0044bfa1df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644454 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:31.526924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:31.527442) ========= script_repo_revision: ab0044bfa1df858919797bcd6a9aef76a668cd4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:31.528066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:31.528464) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:31.539914) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-27 04:26:31.540443) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:26:31 INFO - MultiFileLogger online at 20160427 04:26:31 in /builds/slave/test 04:26:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:26:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:31 INFO - {'append_to_log': False, 04:26:31 INFO - 'base_work_dir': '/builds/slave/test', 04:26:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:26:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:31 INFO - 'branch': 'Firefox-Non-PGO', 04:26:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:31 INFO - 'config_files': ('talos/linux_config.py',), 04:26:31 INFO - 'default_actions': ('clobber', 04:26:31 INFO - 'read-buildbot-config', 04:26:31 INFO - 'download-and-extract', 04:26:31 INFO - 'populate-webroot', 04:26:31 INFO - 'create-virtualenv', 04:26:31 INFO - 'install', 04:26:31 INFO - 'run-tests'), 04:26:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:31 INFO - 'download_minidump_stackwalk': True, 04:26:31 INFO - 'download_symbols': 'ondemand', 04:26:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:31 INFO - 'installer_path': 'installer.exe', 04:26:31 INFO - 'log_level': 'info', 04:26:31 INFO - 'log_name': 'talos', 04:26:31 INFO - 'log_to_console': True, 04:26:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:26:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:26:31 INFO - 'opt_config_files': (), 04:26:31 INFO - 'pip_index': False, 04:26:31 INFO - 'sps_profile': False, 04:26:31 INFO - 'sps_profile_interval': 0, 04:26:31 INFO - 'suite': 'dromaeojs-e10s', 04:26:31 INFO - 'system_bits': '32', 04:26:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:31 INFO - 'title': 'talos-linux64-ix-054', 04:26:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:31 INFO - 'use_talos_json': True, 04:26:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:31 INFO - 'work_dir': 'build'} 04:26:31 INFO - ##### 04:26:31 INFO - ##### Running clobber step. 04:26:31 INFO - ##### 04:26:31 INFO - Running pre-action listener: _resource_record_pre_action 04:26:31 INFO - Running main action method: clobber 04:26:31 INFO - rmtree: /builds/slave/test/build 04:26:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:32 INFO - Running post-action listener: _resource_record_post_action 04:26:32 INFO - ##### 04:26:32 INFO - ##### Running read-buildbot-config step. 04:26:32 INFO - ##### 04:26:32 INFO - Running pre-action listener: _resource_record_pre_action 04:26:32 INFO - Running main action method: read_buildbot_config 04:26:32 INFO - Using buildbot properties: 04:26:32 INFO - { 04:26:32 INFO - "project": "", 04:26:32 INFO - "product": "firefox", 04:26:32 INFO - "script_repo_revision": "production", 04:26:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:26:32 INFO - "repository": "", 04:26:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:26:32 INFO - "buildid": "20160427025907", 04:26:32 INFO - "pgo_build": "False", 04:26:32 INFO - "basedir": "/builds/slave/test", 04:26:32 INFO - "buildnumber": 41, 04:26:32 INFO - "slavename": "talos-linux64-ix-054", 04:26:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:26:32 INFO - "platform": "ubuntu64_hw", 04:26:32 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:26:32 INFO - "branch": "mozilla-central", 04:26:32 INFO - "repo_path": "mozilla-central", 04:26:32 INFO - "revision": "ab0044bfa1df858919797bcd6a9aef76a668cd4a", 04:26:32 INFO - "stage_platform": "linux64", 04:26:32 INFO - "builduid": "946947c12dd542b49bd94d42b335f8ba", 04:26:32 INFO - "slavebuilddir": "test" 04:26:32 INFO - } 04:26:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:26:32 INFO - Running post-action listener: _resource_record_post_action 04:26:32 INFO - ##### 04:26:32 INFO - ##### Running download-and-extract step. 04:26:32 INFO - ##### 04:26:32 INFO - Running pre-action listener: _resource_record_pre_action 04:26:32 INFO - Running main action method: download_and_extract 04:26:32 INFO - mkdir: /builds/slave/test/build/tests 04:26:32 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:26:32 INFO - https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:26:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:26:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:26:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/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:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/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:26:42 INFO - Downloaded 1361 bytes. 04:26:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:26:42 INFO - Using the following test package requirements: 04:26:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:26:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:26:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'jsshell-linux-x86_64.zip'], 04:26:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:26:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:26:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:26:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:26:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:26:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:42 INFO - https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/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:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/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:26:44 INFO - Downloaded 22293773 bytes. 04:26:44 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:26:44 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:26:45 INFO - Return code: 0 04:26:45 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:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:45 INFO - https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/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:26:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/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:26:48 INFO - Downloaded 22293773 bytes. 04:26:48 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:26:48 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:26:50 INFO - Return code: 0 04:26:50 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:26:50 INFO - https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:26:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/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:26:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/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:26:51 INFO - Downloaded 10840145 bytes. 04:26:51 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:26:51 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:26:51 INFO - Return code: 0 04:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:51 INFO - https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:26:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:26:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:26:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/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:26:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/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:26:53 INFO - Downloaded 54817963 bytes. 04:26:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:26:53 INFO - mkdir: /builds/slave/test/properties 04:26:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:26:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:26:53 INFO - Contents: 04:26:53 INFO - build_url:https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:26:54 INFO - Running post-action listener: _resource_record_post_action 04:26:54 INFO - Running post-action listener: set_extra_try_arguments 04:26:54 INFO - ##### 04:26:54 INFO - ##### Running populate-webroot step. 04:26:54 INFO - ##### 04:26:54 INFO - Running pre-action listener: _resource_record_pre_action 04:26:54 INFO - Running main action method: populate_webroot 04:26:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:26:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:26:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:26:54 INFO - '--tppagecycles', 04:26:54 INFO - '7'], 04:26:54 INFO - 'tests': ['tsvgm']}}, 04:26:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:26:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:26:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:26:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:26:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:26:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:26:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:54 INFO - 'talos_options': ['--disable-e10s'], 04:26:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:54 INFO - 'talos_options': ['--disable-e10s'], 04:26:54 INFO - 'tests': ['damp', 'tps']}, 04:26:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:54 INFO - 'tests': ['damp', 'tps']}, 04:26:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:26:54 INFO - 'tests': ['dromaeo_dom']}, 04:26:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:26:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:26:54 INFO - 'tests': ['a11yr', 04:26:54 INFO - 'ts_paint', 04:26:54 INFO - 'tpaint', 04:26:54 INFO - 'sessionrestore', 04:26:54 INFO - 'sessionrestore_no_auto_restore', 04:26:54 INFO - 'tabpaint']}, 04:26:54 INFO - 'other-e10s': {'tests': ['a11yr', 04:26:54 INFO - 'ts_paint', 04:26:54 INFO - 'tpaint', 04:26:54 INFO - 'sessionrestore', 04:26:54 INFO - 'sessionrestore_no_auto_restore', 04:26:54 INFO - 'tabpaint']}, 04:26:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:26:54 INFO - 'ts_paint', 04:26:54 INFO - 'tpaint', 04:26:54 INFO - 'sessionrestore', 04:26:54 INFO - 'sessionrestore_no_auto_restore', 04:26:54 INFO - 'tabpaint']}, 04:26:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:26:54 INFO - 'ts_paint', 04:26:54 INFO - 'tpaint', 04:26:54 INFO - 'sessionrestore', 04:26:54 INFO - 'sessionrestore_no_auto_restore', 04:26:54 INFO - 'tabpaint']}, 04:26:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:26:54 INFO - 'tests': ['a11yr', 04:26:54 INFO - 'ts_paint', 04:26:54 INFO - 'tpaint', 04:26:54 INFO - 'sessionrestore', 04:26:54 INFO - 'sessionrestore_no_auto_restore', 04:26:54 INFO - 'tabpaint']}, 04:26:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:26:54 INFO - 'tests': ['a11yr', 04:26:54 INFO - 'ts_paint', 04:26:54 INFO - 'tpaint', 04:26:54 INFO - 'sessionrestore', 04:26:54 INFO - 'sessionrestore_no_auto_restore', 04:26:54 INFO - 'tabpaint']}, 04:26:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:26:54 INFO - 'tests': ['tsvgx', 04:26:54 INFO - 'tsvgr_opacity', 04:26:54 INFO - 'tart', 04:26:54 INFO - 'tscrollx', 04:26:54 INFO - 'cart']}, 04:26:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:26:54 INFO - 'tsvgr_opacity', 04:26:54 INFO - 'tart', 04:26:54 INFO - 'tscrollx', 04:26:54 INFO - 'cart']}, 04:26:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:54 INFO - 'talos_options': ['--disable-e10s'], 04:26:54 INFO - 'tests': ['tp5o']}, 04:26:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:54 INFO - 'tests': ['tp5o']}, 04:26:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:54 INFO - 'talos_options': ['--disable-e10s', 04:26:54 INFO - '--xperf_path', 04:26:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:54 INFO - 'tests': ['tp5n']}, 04:26:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:54 INFO - 'talos_options': ['--xperf_path', 04:26:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:54 INFO - 'tests': ['tp5n']}}, 04:26:54 INFO - 'talos.zip': {'path': '', 04:26:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:26:54 INFO - Running post-action listener: _resource_record_post_action 04:26:54 INFO - ##### 04:26:54 INFO - ##### Running create-virtualenv step. 04:26:54 INFO - ##### 04:26:54 INFO - Running pre-action listener: _resource_record_pre_action 04:26:54 INFO - Running main action method: create_virtualenv 04:26:54 INFO - Creating virtualenv /builds/slave/test/build/venv 04:26:54 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:26:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:26:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:26:54 INFO - Using real prefix '/usr' 04:26:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:26:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:26:56 INFO - Installing pip.................done. 04:26:56 INFO - Return code: 0 04:26:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b43aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f410>, '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 0x1340310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13407a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', '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:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:26:56 INFO - Using env: {'DISPLAY': ':0', 04:26:56 INFO - 'HOME': '/home/cltbld', 04:26:56 INFO - 'LANG': 'en_US.UTF-8', 04:26:56 INFO - 'LANGUAGE': 'en_US:en', 04:26:56 INFO - 'LOGNAME': 'cltbld', 04:26:56 INFO - 'MAIL': '/var/mail/cltbld', 04:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:56 INFO - 'MOZ_NO_REMOTE': '1', 04:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:56 INFO - 'NO_EM_RESTART': '1', 04:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:56 INFO - 'PWD': '/builds/slave/test', 04:26:56 INFO - 'SHELL': '/bin/bash', 04:26:56 INFO - 'SHLVL': '1', 04:26:56 INFO - 'TERM': 'linux', 04:26:56 INFO - 'TMOUT': '86400', 04:26:56 INFO - 'USER': 'cltbld', 04:26:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', 04:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:56 INFO - '_': '/tools/buildbot/bin/python'} 04:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:26:56 INFO - Cleaning up... 04:26:56 INFO - Return code: 0 04:26:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b43aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f410>, '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 0x1340310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13407a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', '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:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:26:56 INFO - Using env: {'DISPLAY': ':0', 04:26:56 INFO - 'HOME': '/home/cltbld', 04:26:56 INFO - 'LANG': 'en_US.UTF-8', 04:26:56 INFO - 'LANGUAGE': 'en_US:en', 04:26:56 INFO - 'LOGNAME': 'cltbld', 04:26:56 INFO - 'MAIL': '/var/mail/cltbld', 04:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:56 INFO - 'MOZ_NO_REMOTE': '1', 04:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:56 INFO - 'NO_EM_RESTART': '1', 04:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:56 INFO - 'PWD': '/builds/slave/test', 04:26:56 INFO - 'SHELL': '/bin/bash', 04:26:56 INFO - 'SHLVL': '1', 04:26:56 INFO - 'TERM': 'linux', 04:26:56 INFO - 'TMOUT': '86400', 04:26:56 INFO - 'USER': 'cltbld', 04:26:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', 04:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:56 INFO - '_': '/tools/buildbot/bin/python'} 04:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:57 INFO - Downloading/unpacking psutil>=0.7.1 04:26:57 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:26:57 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:26:57 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:26:57 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:26:57 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:26:57 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:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:26:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:59 INFO - Installing collected packages: psutil 04:26:59 INFO - Running setup.py install for psutil 04:26:59 INFO - building 'psutil._psutil_linux' extension 04:26:59 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:26:59 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:26:59 INFO - building 'psutil._psutil_posix' extension 04:26:59 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:26:59 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:26:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:59 INFO - Successfully installed psutil 04:26:59 INFO - Cleaning up... 04:26:59 INFO - Return code: 0 04:26:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:59 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 0x7f97b43aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f410>, '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 0x1340310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13407a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', '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:26:59 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:26:59 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:26:59 INFO - Using env: {'DISPLAY': ':0', 04:26:59 INFO - 'HOME': '/home/cltbld', 04:26:59 INFO - 'LANG': 'en_US.UTF-8', 04:26:59 INFO - 'LANGUAGE': 'en_US:en', 04:26:59 INFO - 'LOGNAME': 'cltbld', 04:26:59 INFO - 'MAIL': '/var/mail/cltbld', 04:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:59 INFO - 'MOZ_NO_REMOTE': '1', 04:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:59 INFO - 'NO_EM_RESTART': '1', 04:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:59 INFO - 'PWD': '/builds/slave/test', 04:26:59 INFO - 'SHELL': '/bin/bash', 04:26:59 INFO - 'SHLVL': '1', 04:26:59 INFO - 'TERM': 'linux', 04:26:59 INFO - 'TMOUT': '86400', 04:26:59 INFO - 'USER': 'cltbld', 04:26:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', 04:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:59 INFO - '_': '/tools/buildbot/bin/python'} 04:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:27:01 INFO - Installing collected packages: mozsystemmonitor 04:27:01 INFO - Running setup.py install for mozsystemmonitor 04:27:01 INFO - Successfully installed mozsystemmonitor 04:27:01 INFO - Cleaning up... 04:27:01 INFO - Return code: 0 04:27:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b43aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f410>, '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 0x1340310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13407a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', '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:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:27:01 INFO - Using env: {'DISPLAY': ':0', 04:27:01 INFO - 'HOME': '/home/cltbld', 04:27:01 INFO - 'LANG': 'en_US.UTF-8', 04:27:01 INFO - 'LANGUAGE': 'en_US:en', 04:27:01 INFO - 'LOGNAME': 'cltbld', 04:27:01 INFO - 'MAIL': '/var/mail/cltbld', 04:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:01 INFO - 'MOZ_NO_REMOTE': '1', 04:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:01 INFO - 'NO_EM_RESTART': '1', 04:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:01 INFO - 'PWD': '/builds/slave/test', 04:27:01 INFO - 'SHELL': '/bin/bash', 04:27:01 INFO - 'SHLVL': '1', 04:27:01 INFO - 'TERM': 'linux', 04:27:01 INFO - 'TMOUT': '86400', 04:27:01 INFO - 'USER': 'cltbld', 04:27:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', 04:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:01 INFO - '_': '/tools/buildbot/bin/python'} 04:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:04 INFO - Downloading docopt-0.6.1.tar.gz 04:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:27:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:27:04 INFO - Running setup.py install for blobuploader 04:27:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:27:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:27:04 INFO - Running setup.py install for requests 04:27:05 INFO - Running setup.py install for docopt 04:27:05 INFO - Successfully installed blobuploader requests docopt 04:27:05 INFO - Cleaning up... 04:27:05 INFO - Return code: 0 04:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27: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:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:05 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 0x7f97b43aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f410>, '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 0x1340310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13407a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', '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:27:05 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:27:05 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:27:05 INFO - Using env: {'DISPLAY': ':0', 04:27:05 INFO - 'HOME': '/home/cltbld', 04:27:05 INFO - 'LANG': 'en_US.UTF-8', 04:27:05 INFO - 'LANGUAGE': 'en_US:en', 04:27:05 INFO - 'LOGNAME': 'cltbld', 04:27:05 INFO - 'MAIL': '/var/mail/cltbld', 04:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:05 INFO - 'MOZ_NO_REMOTE': '1', 04:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:05 INFO - 'NO_EM_RESTART': '1', 04:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:05 INFO - 'PWD': '/builds/slave/test', 04:27:05 INFO - 'SHELL': '/bin/bash', 04:27:05 INFO - 'SHLVL': '1', 04:27:05 INFO - 'TERM': 'linux', 04:27:05 INFO - 'TMOUT': '86400', 04:27:05 INFO - 'USER': 'cltbld', 04:27:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', 04:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:05 INFO - '_': '/tools/buildbot/bin/python'} 04:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:05 INFO - Running setup.py (path:/tmp/pip-gsDzK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:05 INFO - Running setup.py (path:/tmp/pip-52D2ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:05 INFO - Running setup.py (path:/tmp/pip-FLFNcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:05 INFO - Running setup.py (path:/tmp/pip-ZcOtci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:05 INFO - Running setup.py (path:/tmp/pip-_epGCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:05 INFO - Running setup.py (path:/tmp/pip-ugpmtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:05 INFO - Running setup.py (path:/tmp/pip-Bj3W81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:06 INFO - Running setup.py (path:/tmp/pip-xIISQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:06 INFO - Running setup.py (path:/tmp/pip-CTl1b0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:06 INFO - Running setup.py (path:/tmp/pip-CqK769-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:06 INFO - Running setup.py (path:/tmp/pip-VOxUZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:06 INFO - Running setup.py (path:/tmp/pip-jvo0Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:06 INFO - Running setup.py (path:/tmp/pip-Ya2X03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:06 INFO - Running setup.py (path:/tmp/pip-QHkqCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:06 INFO - Running setup.py (path:/tmp/pip-wIp1ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:06 INFO - Running setup.py (path:/tmp/pip-3bH_wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:06 INFO - Running setup.py (path:/tmp/pip-Yxlt6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:27:06 INFO - Running setup.py install for manifestparser 04:27:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:27:06 INFO - Running setup.py install for mozcrash 04:27:06 INFO - Running setup.py install for mozdebug 04:27:07 INFO - Running setup.py install for mozdevice 04:27:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:27:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:27:07 INFO - Running setup.py install for mozfile 04:27:07 INFO - Running setup.py install for mozhttpd 04:27:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:27:07 INFO - Running setup.py install for mozinfo 04:27:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:27:07 INFO - Running setup.py install for mozInstall 04:27:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:27:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:27:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:27:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:27:07 INFO - Running setup.py install for mozleak 04:27:07 INFO - Running setup.py install for mozlog 04:27:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:27:07 INFO - Running setup.py install for moznetwork 04:27:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:27:07 INFO - Running setup.py install for mozprocess 04:27:07 INFO - Running setup.py install for mozprofile 04:27:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:27:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:27:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:27:08 INFO - Running setup.py install for mozrunner 04:27:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:27:08 INFO - Running setup.py install for mozscreenshot 04:27:08 INFO - Running setup.py install for moztest 04:27:08 INFO - Running setup.py install for mozversion 04:27:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:27:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:27:08 INFO - Cleaning up... 04:27:08 INFO - Return code: 0 04:27:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:08 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:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:08 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:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:08 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 0x7f97b43aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f410>, '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 0x1340310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13407a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', '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:27:08 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:27:08 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:27:08 INFO - Using env: {'DISPLAY': ':0', 04:27:08 INFO - 'HOME': '/home/cltbld', 04:27:08 INFO - 'LANG': 'en_US.UTF-8', 04:27:08 INFO - 'LANGUAGE': 'en_US:en', 04:27:08 INFO - 'LOGNAME': 'cltbld', 04:27:08 INFO - 'MAIL': '/var/mail/cltbld', 04:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:08 INFO - 'MOZ_NO_REMOTE': '1', 04:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:08 INFO - 'NO_EM_RESTART': '1', 04:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:08 INFO - 'PWD': '/builds/slave/test', 04:27:08 INFO - 'SHELL': '/bin/bash', 04:27:08 INFO - 'SHLVL': '1', 04:27:08 INFO - 'TERM': 'linux', 04:27:08 INFO - 'TMOUT': '86400', 04:27:08 INFO - 'USER': 'cltbld', 04:27:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', 04:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:08 INFO - '_': '/tools/buildbot/bin/python'} 04:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:08 INFO - Running setup.py (path:/tmp/pip-J2S1of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:08 INFO - Running setup.py (path:/tmp/pip-pcfVcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:08 INFO - Running setup.py (path:/tmp/pip-cRqyN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:08 INFO - Running setup.py (path:/tmp/pip-FaOHSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:09 INFO - Running setup.py (path:/tmp/pip-85R0ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:09 INFO - Running setup.py (path:/tmp/pip-NIFVv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:09 INFO - Running setup.py (path:/tmp/pip-uAy1HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:09 INFO - Running setup.py (path:/tmp/pip-JU2IW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:09 INFO - Running setup.py (path:/tmp/pip-ap8aAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:09 INFO - Running setup.py (path:/tmp/pip-5kUHkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:09 INFO - Running setup.py (path:/tmp/pip-EpDPlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:09 INFO - Running setup.py (path:/tmp/pip-rBwGmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:09 INFO - Running setup.py (path:/tmp/pip-HxVjSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:09 INFO - Running setup.py (path:/tmp/pip-_rpqZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:09 INFO - Running setup.py (path:/tmp/pip-UpwJMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:09 INFO - Running setup.py (path:/tmp/pip-NRZNg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:09 INFO - Running setup.py (path:/tmp/pip-8s3qBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:27:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:11 INFO - Downloading blessings-1.6.tar.gz 04:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:11 INFO - Installing collected packages: blessings 04:27:11 INFO - Running setup.py install for blessings 04:27:12 INFO - Successfully installed blessings 04:27:12 INFO - Cleaning up... 04:27:12 INFO - Return code: 0 04:27:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:12 INFO - Reading from file tmpfile_stdout 04:27:12 INFO - Current package versions: 04:27:12 INFO - argparse == 1.2.1 04:27:12 INFO - blessings == 1.6 04:27:12 INFO - blobuploader == 1.2.4 04:27:12 INFO - docopt == 0.6.1 04:27:12 INFO - manifestparser == 1.1 04:27:12 INFO - mozInstall == 1.12 04:27:12 INFO - mozcrash == 0.17 04:27:12 INFO - mozdebug == 0.1 04:27:12 INFO - mozdevice == 0.48 04:27:12 INFO - mozfile == 1.2 04:27:12 INFO - mozhttpd == 0.7 04:27:12 INFO - mozinfo == 0.9 04:27:12 INFO - mozleak == 0.1 04:27:12 INFO - mozlog == 3.1 04:27:12 INFO - moznetwork == 0.27 04:27:12 INFO - mozprocess == 0.22 04:27:12 INFO - mozprofile == 0.28 04:27:12 INFO - mozrunner == 6.11 04:27:12 INFO - mozscreenshot == 0.1 04:27:12 INFO - mozsystemmonitor == 0.0 04:27:12 INFO - moztest == 0.7 04:27:12 INFO - mozversion == 1.4 04:27:12 INFO - psutil == 3.1.1 04:27:12 INFO - requests == 1.2.3 04:27:12 INFO - wsgiref == 0.1.2 04:27:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:12 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:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:12 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:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:12 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 0x7f97b43aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f410>, '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 0x1340310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13407a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', '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:27:12 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:27:12 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:27:12 INFO - Using env: {'DISPLAY': ':0', 04:27:12 INFO - 'HOME': '/home/cltbld', 04:27:12 INFO - 'LANG': 'en_US.UTF-8', 04:27:12 INFO - 'LANGUAGE': 'en_US:en', 04:27:12 INFO - 'LOGNAME': 'cltbld', 04:27:12 INFO - 'MAIL': '/var/mail/cltbld', 04:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:12 INFO - 'MOZ_NO_REMOTE': '1', 04:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:12 INFO - 'NO_EM_RESTART': '1', 04:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:12 INFO - 'PWD': '/builds/slave/test', 04:27:12 INFO - 'SHELL': '/bin/bash', 04:27:12 INFO - 'SHLVL': '1', 04:27:12 INFO - 'TERM': 'linux', 04:27:12 INFO - 'TMOUT': '86400', 04:27:12 INFO - 'USER': 'cltbld', 04:27:12 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', 04:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:12 INFO - '_': '/tools/buildbot/bin/python'} 04:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 INFO - Cleaning up... 04:27:12 INFO - Return code: 0 04:27:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27:12 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:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:12 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:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:12 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 0x7f97b43aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f410>, '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 0x1340310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13407a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', '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:27:12 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:27:12 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:27:12 INFO - Using env: {'DISPLAY': ':0', 04:27:12 INFO - 'HOME': '/home/cltbld', 04:27:12 INFO - 'LANG': 'en_US.UTF-8', 04:27:12 INFO - 'LANGUAGE': 'en_US:en', 04:27:12 INFO - 'LOGNAME': 'cltbld', 04:27:12 INFO - 'MAIL': '/var/mail/cltbld', 04:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:12 INFO - 'MOZ_NO_REMOTE': '1', 04:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:12 INFO - 'NO_EM_RESTART': '1', 04:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:12 INFO - 'PWD': '/builds/slave/test', 04:27:12 INFO - 'SHELL': '/bin/bash', 04:27:12 INFO - 'SHLVL': '1', 04:27:12 INFO - 'TERM': 'linux', 04:27:12 INFO - 'TMOUT': '86400', 04:27:12 INFO - 'USER': 'cltbld', 04:27:12 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', 04:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:12 INFO - '_': '/tools/buildbot/bin/python'} 04:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:12 INFO - Downloading/unpacking jsonschema 04:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:14 INFO - Downloading/unpacking functools32 (from jsonschema) 04:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:14 INFO - warning: no files found matching '*.txt' 04:27:14 INFO - no previously-included directories found matching 'build' 04:27:14 INFO - no previously-included directories found matching 'dist' 04:27:14 INFO - no previously-included directories found matching '.git*' 04:27:14 INFO - Installing collected packages: jsonschema, functools32 04:27:14 INFO - Running setup.py install for functools32 04:27:15 INFO - warning: no files found matching '*.txt' 04:27:15 INFO - no previously-included directories found matching 'build' 04:27:15 INFO - no previously-included directories found matching 'dist' 04:27:15 INFO - no previously-included directories found matching '.git*' 04:27:15 INFO - Successfully installed jsonschema functools32 04:27:15 INFO - Cleaning up... 04:27:15 INFO - Return code: 0 04:27:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:27: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:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:15 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 0x7f97b43aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f410>, '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 0x1340310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13407a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', '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:27:15 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:27:15 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:27:15 INFO - Using env: {'DISPLAY': ':0', 04:27:15 INFO - 'HOME': '/home/cltbld', 04:27:15 INFO - 'LANG': 'en_US.UTF-8', 04:27:15 INFO - 'LANGUAGE': 'en_US:en', 04:27:15 INFO - 'LOGNAME': 'cltbld', 04:27:15 INFO - 'MAIL': '/var/mail/cltbld', 04:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:15 INFO - 'MOZ_NO_REMOTE': '1', 04:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:15 INFO - 'NO_EM_RESTART': '1', 04:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:15 INFO - 'PWD': '/builds/slave/test', 04:27:15 INFO - 'SHELL': '/bin/bash', 04:27:15 INFO - 'SHLVL': '1', 04:27:15 INFO - 'TERM': 'linux', 04:27:15 INFO - 'TMOUT': '86400', 04:27:15 INFO - 'USER': 'cltbld', 04:27:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', 04:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:15 INFO - '_': '/tools/buildbot/bin/python'} 04:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:15 INFO - Downloading/unpacking flake8 04:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:27:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:27:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:27:17 INFO - no previously-included directories found matching 'docs/_build' 04:27:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:27:17 INFO - Running setup.py install for pep8 04:27:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:27:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:27:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:27:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:27:18 INFO - no previously-included directories found matching 'docs/_build' 04:27:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:27:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:27:18 INFO - Cleaning up... 04:27:18 INFO - Return code: 0 04:27:18 INFO - Running post-action listener: _resource_record_post_action 04:27:18 INFO - Running post-action listener: _start_resource_monitoring 04:27:18 INFO - Starting resource monitoring. 04:27:18 INFO - ##### 04:27:18 INFO - ##### Running install step. 04:27:18 INFO - ##### 04:27:18 INFO - Running pre-action listener: _resource_record_pre_action 04:27:18 INFO - Running main action method: install 04:27:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:18 INFO - Reading from file tmpfile_stdout 04:27:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:18 INFO - Reading from file tmpfile_stdout 04:27:18 INFO - Output received: 04:27:18 INFO - Usage: mozinstall [options] installer 04:27:18 INFO - Options: 04:27:18 INFO - -h, --help show this help message and exit 04:27:18 INFO - -d DEST, --destination=DEST 04:27:18 INFO - Directory to install application into. [default: 04:27:18 INFO - "/builds/slave/test"] 04:27:18 INFO - --app=APP Application being installed. [default: firefox] 04:27:18 INFO - mkdir: /builds/slave/test/build/application 04:27:18 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:27:18 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:27:34 INFO - Reading from file tmpfile_stdout 04:27:34 INFO - Output received: 04:27:34 INFO - /builds/slave/test/build/application/firefox/firefox 04:27:34 INFO - Running post-action listener: _resource_record_post_action 04:27:34 INFO - ##### 04:27:34 INFO - ##### Running run-tests step. 04:27:34 INFO - ##### 04:27:34 INFO - Running pre-action listener: _resource_record_pre_action 04:27:34 INFO - Running main action method: run_tests 04:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:34 INFO - Python 2.7.3 04:27:34 INFO - Return code: 0 04:27:34 INFO - grabbing minidump binary from tooltool 04:27:34 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:27:34 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 0x133f410>, '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 0x1340310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13407a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27:34 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:27:34 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:27:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:34 INFO - Return code: 0 04:27:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:27:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:27:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:27:35 INFO - Return code: 0 04:27:35 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:27:35 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:27:35 INFO - Using env: {'DISPLAY': ':0', 04:27:35 INFO - 'HOME': '/home/cltbld', 04:27:35 INFO - 'LANG': 'en_US.UTF-8', 04:27:35 INFO - 'LANGUAGE': 'en_US:en', 04:27:35 INFO - 'LOGNAME': 'cltbld', 04:27:35 INFO - 'MAIL': '/var/mail/cltbld', 04:27:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:35 INFO - 'MOZ_NO_REMOTE': '1', 04:27:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:35 INFO - 'NO_EM_RESTART': '1', 04:27:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:35 INFO - 'PWD': '/builds/slave/test', 04:27:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:35 INFO - 'SHELL': '/bin/bash', 04:27:35 INFO - 'SHLVL': '1', 04:27:35 INFO - 'TERM': 'linux', 04:27:35 INFO - 'TMOUT': '86400', 04:27:35 INFO - 'USER': 'cltbld', 04:27:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724', 04:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:35 INFO - '_': '/tools/buildbot/bin/python'} 04:27:35 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:27:35 INFO - mozversion application_buildid: 20160427025907 04:27:35 INFO - mozversion application_changeset: ab0044bfa1df858919797bcd6a9aef76a668cd4a 04:27:35 INFO - mozversion application_display_name: Nightly 04:27:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:35 INFO - mozversion application_name: Firefox 04:27:35 INFO - mozversion application_remotingname: firefox 04:27:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:27:35 INFO - mozversion application_vendor: Mozilla 04:27:35 INFO - mozversion application_version: 49.0a1 04:27:35 INFO - mozversion platform_buildid: 20160427025907 04:27:35 INFO - mozversion platform_changeset: ab0044bfa1df858919797bcd6a9aef76a668cd4a 04:27:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:27:35 INFO - mozversion platform_version: 49.0a1 04:27:35 INFO - using testdate: 1461756455 04:27:35 INFO - actual date: 1461756455 04:27:35 INFO - starting webserver on 'localhost:37639' 04:27:35 INFO - SUITE-START | Running 2 tests 04:27:35 INFO - TEST-START | dromaeo_css 04:27:35 INFO - operating with platform_type : linux_ 04:27:35 INFO - Initialising browser for dromaeo_css test... 04:27:35 INFO - TEST-INFO | started process 5241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzztUfm/profile http://localhost:37639/getInfo.html) 04:27:39 INFO - PROCESS | 5241 | 04:27:39 INFO - PROCESS | 5241 | (process:5308): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:27:40 INFO - PROCESS | 5241 | __metrics Screen width/height:1600/1200 04:27:40 INFO - PROCESS | 5241 | colorDepth:24 04:27:40 INFO - PROCESS | 5241 | Browser inner width/height: 1024/697 04:27:40 INFO - PROCESS | 5241 | __metrics 04:27:41 ERROR - PROCESS | 5241 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:27:42 INFO - TEST-INFO | 5241: exit 0 04:27:42 INFO - Browser initialized. 04:27:42 INFO - Running cycle 1/1 for dromaeo_css test... 04:27:42 INFO - TEST-INFO | started process 5359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzztUfm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:44 INFO - PROCESS | 5359 | 04:27:44 INFO - PROCESS | 5359 | (process:5419): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:27:54 INFO - PROCESS | 5359 | RSS: Main: 166060032 04:27:54 INFO - PROCESS | 5359 | 04:28:44 INFO - PROCESS | 5359 | 1461756524054 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:30:55 INFO - PROCESS | 5359 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37639/tests/dromaeo/cssquery-ext.html) 04:30:56 INFO - PROCESS | 5359 | RSS: Main: 170741760 04:30:56 INFO - PROCESS | 5359 | 04:33:59 INFO - PROCESS | 5359 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-ext.html (next: http://localhost:37639/tests/dromaeo/cssquery-jquery.html) 04:33:59 INFO - PROCESS | 5359 | RSS: Main: 166817792 04:33:59 INFO - PROCESS | 5359 | 04:37:01 INFO - PROCESS | 5359 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37639/tests/dromaeo/cssquery-mootools.html) 04:37:02 INFO - PROCESS | 5359 | RSS: Main: 168267776 04:37:02 INFO - PROCESS | 5359 | 04:40:03 INFO - PROCESS | 5359 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37639/tests/dromaeo/cssquery-prototype.html) 04:40:04 INFO - PROCESS | 5359 | RSS: Main: 166191104 04:40:04 INFO - PROCESS | 5359 | 04:43:07 INFO - PROCESS | 5359 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37639/tests/dromaeo/cssquery-yui.html) 04:43:07 INFO - PROCESS | 5359 | RSS: Main: 167501824 04:43:07 INFO - PROCESS | 5359 | 04:46:10 INFO - PROCESS | 5359 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-yui.html (next: http://localhost:37639/tests/dromaeo/cssquery-dojo.html) 04:46:10 INFO - PROCESS | 5359 | RSS: Main: 169398272 04:46:10 INFO - PROCESS | 5359 | 04:46:10 INFO - PROCESS | 5359 | __start_tp_report 04:46:10 INFO - PROCESS | 5359 | _x_x_mozilla_page_load 04:46:10 INFO - PROCESS | 5359 | _x_x_mozilla_page_load_details 04:46:10 INFO - PROCESS | 5359 | |i|pagename|runs| 04:46:10 INFO - PROCESS | 5359 | |0;dojo.html;2639.0631325879312;2709.0924540279007;2723.8774255158514;2733.1663842528033;2746.093789049614;4743.691660042099;4779.71321720697;4799.712017278957;4802.1836287831065;4836.806527738886;4644.744539050351;4741.431028276603;4784.378030855993;4784.44978827435;4871.293662418947;4352.499462561798;4419.558044195587;4420.07178492517;4421.624161946223;4428.512863585003;664.0886687721312;4213.115245798386;4281.207976524337;4367.759773212472;4389.23188442023;4368.322909948963;4411.338299255105;4413.801378937956;4421.358902959069;4433.578810013044;4410.514843367227;4413.580709832593;4421.403110580062;4432.024954510002;4452.109578084363;4211.115665710205;4348.4999225089205;4375.453068366454;4387.780610969438;4425.911481770347;4721.102990431807;4721.811127554894;4736.147493451177;4738.312944623045;4762.28565715142;5113.846584602431;5147.897042059138;5158.484151584849;5169.2504586835075;5174.249733788617;4980.402351717781;5117.257997590328;5195.844124676266;5214.270002199657;5220.086484865134;4732.692374995683;4746.003339298717;4749.952500474986;4765.833195838164;4781.971876046667;5208.166693329049;5214.348206474191;5214.504622060898;5225.686458812484;5266.815661451831;4837.733924634109;4893.119238537098;4939.3084968104495;4965.230389289666;4986.750662466935;5071.442141364447;5090.211017292251;5094.439611642716;5102.846914592568;5159.74201289934;4928.8767780805765;5034.924476132861;5038.496150385005;5046.9747651261505;5047.97476012625;5015.3229314042865;5043.142665746832;5053.166227572483;5084.669496482717;5095.337606111256;4183.226103170923;4187.392828039917;4198.9370159447635;4224.8732538023905;4232.830686772495;3662.8901132966053;3700.296943580765;3702.129999450127;3723.255348930225;3758.0980564664283;4364.8472303469225;4371.78141092944;4420.734755914656;4449.443819522559;4454.510003899569;5059.215821547666;5064.240363945438;5082.822101226439;5148.485151484896;5244.318238628954;4508.301213311942;4521.367008618796;4530.4110465639915;4531.297648864432;4567.177907976529;4543.909121817611;4603.976980115078;4616.3537104805355;4623.976880115578;4660.790264438108;4749.35883655702;4839.467658557556;4841.273808928689;4841.491643377394;4844.515548445127;5059.418166910705;5096.923546146885;5123.410807757155;5163.148080566664;5174.197999310113;4834.492378300228;4855.320255164209;4863.513648635108;4879;4904.141775189399;4933.186024305949;5037.672551284155;5043.672161309503;5074.11203039474;5086.465921078381;5118.795248190179;5132.486751324837;5140.4088529818055;5143.8456846294675;5173.896522069613;4901.9264711028645;4908.828191013297;4910.165271903714;4912.533309335608;4953.430355509163;4831.613470922248;4901.240307752304;4916.70499770015;4938.1358262304675;5001.57486613642;4773.284007398779;4795.256735206049;4801.399825021872;4837.975810120927;4869.756512174448;4899.485554016919;4908.901821963469;4920.21276595743;4924.482929292372;4978.601711863114;4756.857294281177;4807.759612019455;4837.903241935212;4871.415430148405;4909.018196360814 04:46:10 INFO - PROCESS | 5359 | |1;ext.html;558.1865743487014;577.9393163717809;596.0552524249063;601.888650599639;634.898416253399;31796.36407271853;32580.348393032124;32602.184945376317;32742.181445463844;32909.50635740466;35799.284014319695;36357.63642363582;36657.26685466296;36756;36781.63218367816;7568.09182898053;7720.61396930154;7786.532808031508;7786.922130778677;7787.844243115134;7586.431017673696;7620.466567340289;7678.347340476066;7685.692572297129;7691.884621730678;7662.310392064713;7692.807679808022;7717.151113377524;7730.420218483636;7750.186230445806;7641.808954776147;7660.578668173248;7692.576908270043;7719.189485104067;7723.0732312122345;7643.350315223212;7687.500312479671;7697.846043079163;7785.182555831613;7795.33739632132;34414.82792586046;34541.13647158816;34748.65251347479;34788;34965.475517866995;3117.688231176887;3299;3652.0213699067103;3764.0966168119726;3858.8649397271242;27030.32424189391;27423.314417139532;27716.861415692994;27806.165815025583;27969.300767480774;3452.896413107611;3538.929221415583;3547.2373439710327;3561.51919490868;3590.694790942773;179160;183983;184242.07878960654;185707;195185;47283.29075063877;47694;47836;48047.75976120097;48116;48806.26790598144;50551.24173137406;50719.985600287786;50936.23595646068;55283.72358138183;13494.52769153075;13718.451261949609;13724.519641812689;13731.244781536912;13737.793933091012;10302.536385862504;10312.484375781181;10312.639057633098;10346.37921724699;10351.482425878676;16650.16749162537;16715.498535043967;16797.664046718997;16813.243404046847;16857.747133793004;6803.217629972616;6822.249552549216;6970.860582788316;6981;7220.133583969852;842.6292431330195;869.9869501957476;895.1943251073956;901.6032945503957;970.7281961050917;26207.475850483264;27235.319117022234;27295.590566141524;27340.45319093607;27655.170344889684;956.2923436656963;975.5805003848271;978.7553111722069;1006.6577363696379;1070.7757895103896;13365.732685346238;13602.115862468909;13798.65503362404;13946.16323020622;14033;269866;270842;272113;273599;273927;46112.308315375296;46395;46701.53298466972;46787;46972;1238.2632333761399;1251.4868903749418;1267.0687045021903;1269.9111062225556;1327.0378975242872;24497.65262910557;26133.477330452904;26641.33396665099;26771;26839.865800670872;40260.39609405803;40656.59343406646;40698.186036278516;40792.53263472638;40908.59091409167;226981;229110;229649;229667;230290;24264.51470970606;33273.66726332706;34165.487517687754;34433.82783086068;34626.48060279048;36054.4591831128;36513;36605.450918235714;37003.44494832526;37919.24161516699;31514.212144696565;31594.52608210833;31943.68056319407;32843.50734739029;35267.47098793572;33352.33295334128;33483;33492;34268.65731342655;34666.65333346735;27225.69099025671;31357;32111;33967.83016084904;34355;28341.574876377283;29204.853975729984;29223.73972684937;29346.559801602565;29457.55813662754;22576.887115564317;23120.306390808302;24207.51584968326;24262.878685606458;24703 04:46:10 INFO - PROCESS | 5359 | |2;jquery.html;374.4121728885649;379.8575534174685;380.30024754451813;381.1690514678003;382.5371300726121;15414.152221627806;15677.529674109766;16110.677786444265;16271.51185464438;16316.184190790473;15264;15783.92108039461;16416.261268242928;16426.17869106543;16466.670666586662;4927.1377508935975;5045.192769156935;5093.414257360396;5093.821716239932;5098.337216161894;3633.382325004742;5002.324686167375;5428.4028756836915;5706.657600543981;5711.857203569903;5597.63615365002;5599.216109744639;5631.8028868989595;5632.549396048326;5671.829845104633;5350.5184533391985;5766.88466230673;5770.04794208955;5790.913136302959;5793.13103034544;4912.803487860481;5060;5101.464346243628;5103.157978933508;5107.259447380146;18857.62284754311;19009.809901900942;19270.90364548168;19394.709079363678;19433.9028304859;1990.741203643517;2023.4030960866432;2037.4397040813747;2044.7137400763904;2052.445839623308;12094.939525302318;12506.937465312707;12632.68418289541;12644.62066138008;12820.294883781387;1760.9823901760947;1830.4142674344216;1831.716084006981;1832.1388947194798;1868.9719654205198;54799.72600137014;56788.71605641946;57030.7148464255;57316;57646.13530797041;9010.189082982562;9148.405353652124;9473.952630236805;9506.096920792514;9694.951525242328;12785.872141278654;12809.359532023362;12913.354332283348;12985.28580928039;13001.15492492985;7144.642767861586;7355.411567074621;7417.629118544051;7427.108746950401;7493.962530187314;7089.22018577956;7089.574625522485;7187.532810367309;7189.7483588074165;7275.236100209508;5903.203067585907;5904.439078287642;5941.1088336749835;5958.940410595926;6121.846953826101;1609.2919115589104;1701.19193383142;1792.5160206744106;1833.092619153501;1863.990680046591;818.6807145213371;922.5295099499169;948.3977674176947;967.1150896929372;999.1656966432964;14876.776848347283;15003;15155.469558565397;15220.847791521943;15405.152716600694;889.5285498685707;904.9185573298435;914.6798620482778;923.8891333040078;962.3456049886005;9391.342606017513;9429.387089839138;9430.858537121949;9479.857802132974;9584.808303833885;284579;289735;291999;351906.2023449383;370848;44540.77729611331;45103.54896451059;45497.31754023692;66065.33934660592;70120;918.4581097152712;939.9718008459757;945.2107490245722;950.7290422229631;959.9808003839884;14378.640533986734;14752;14830.777538336717;14847.777283340974;15021.624459388602;23996.480369560944;27682.723172768016;32698.182545435604;32829.34341313112;32835;40365.39451908165;43859.561404385546;44036.779816100716;44639.330410044524;45172.548274516834;7167.319104685047;7178.174509931425;7186.281371862772;7430.219826918312;7580.824972129329;9523.809523809623;10886.67339979802;11010.944945275221;11158.442077896236;11189.04893084097;9047.773805654911;9256.49089300095;9563.139317461462;9668.419894806335;9765.365251258645;9551.379160354554;9567;9628.855567166638;9900.653477128266;10094.19246460296;5154.896902061862;8311.916880831357;9484.340240457754;10059.19526437898;10128.59485620567;7210.89183662256;7345.1553071397475;7418.591977441292;7531.736389226351;7564.924350756422;9864.260180486348;9878.209743220381;9930.205583553154;10007.699769006942;10092 04:46:10 INFO - PROCESS | 5359 | |3;mootools.html;1412.1668215752707;1434.2183509987058;1540.252977306007;1684.5451728033424;1718.6390857919844;6326.398992095744;6692.832679183023;6725.293844146356;6942.5073609174015;6957.826054348644;6672.633005184713;6706.094677218574;6741.66291685415;6760.96619516903;6788.287229840869;2127.5425783456553;2179.6294629912954;2182.8144607708364;2184.377452426059;2189.069645400706;2105.2947262667026;2136.241634219853;2156.3746513511064;2162.686410470481;2168.349495151448;2139.5079131799694;2156.6010288096672;2161.459635091227;2163.1455575047926;2188.518525924294;2121.087932189158;2133.7012818205385;2133.7546182189094;2135.9679604805942;2141.3575927221927;2097.4022403614895;2190.233418303597;2190.726159230096;2193.605151072806;2198.1427243375097;6946.72213111475;7009.754658586925;7026.789196324118;7040.788776336718;7043.718251269943;4366.279563871957;4471.5081341052455;4495.910081798378;4496.842610508649;4500.819967201308;2727.8226915250443;2762.709915458888;2849.173739615509;2851.5294976328883;2872.8994485192916;893.5576889439769;920.1994264989502;928.535732133933;949.7245798718363;963.0658261486348;8901.376903616685;8915.73252802417;8964.282857371394;8983.191512763817;9000.684976025808;4112.342025276002;4157.521884983205;4207.0954744729415;4264.488261408589;4271.444712187395;7919.524828510308;7925.801854953672;7955.920440795518;7978.042634883851;7980.162082981319;4503.887402814956;4524.8416305429155;4550.294704320836;4551.613112885376;4564.178447879347;3559.14580500678;3988.920221595552;4108.712390132662;4130.958690413057;4163.458750362433;3486.459598762196;3561.6438356164695;3581.8746343877838;3585.731070169748;3655.3420384331075;1195.0618764270007;1201.6515210588832;1208.5951206345796;1232.034904327596;1233.3278363292027;743.9739609113655;761.13611051457;792.631426386733;878.9208971192623;899.8605216191501;4756.048790241965;4920.6555541111775;4941.061198372297;4975.527324904128;5056.68526183195;832.5795473285951;856.1609622569916;857.5926434943477;871.9215270625674;911.3939230411702;3436.1409647588102;3450.585929688403;3501.2122272488486;3537.663921927413;3567.982160089183;7928.801779955432;8134.59327033646;8151;8182.509049457051;8239.052508961546;8282.420230583923;8330.333573314121;8340.62467188978;8363.289120424832;8387.412881098386;6591.670416479157;6602.372774586406;6644.568103073285;6654.800355989328;6704.3295670433545;4573.954260457486;4733.431988161443;4737.692050016738;4738.691985020962;4775.904481910273;7763.961180194063;7813.453058285865;7888.84222315562;7921.762347129596;7962.402819788424;7841.764747057598;7870.606469676608;7930.524168549906;7959.124496305286;8036.156203598538;5459.372172200089;5717.971410142923;5798.768049277982;5928.703564821828;5985.640861548147;6599.934000660124;6607;6627.436667883284;6650.135482387453;6674.365935236145;6099.054646529795;6100.481459076028;6213.285472170758;6280.466160376419;6284.465820405317;5894.941050589439;5981.132735753378;6012.549058820518;6078.361772014052;6088;5725.799597014085;5777.566682498746;5792.94207057924;5800.158976948234;5806.535477161901;4062.532808727034;4176.9791151045265;4217.599328063829;4306.569343065794;4309.956900430955;4315.3095504719095;4324.524302326805;4418.645207902641;4429.047754732748;4470.798814053311 04:46:10 INFO - PROCESS | 5359 | |4;prototype.html;306.47898572426874;313.687880558844;313.8415100374311;315.44954055173724;318.9553462515247;4934.3585333906585;4999.950000499994;5004.174311238646;5007.599392048636;5007.724575148365;4868.196747536652;4874.6831455955335;4901.1177987962155;4903.730294833783;4907.8773030674165;3701.426278926764;3780.3006443807844;3891.0544727636184;3919.823607937635;3920.3335432976464;3912.354461513861;3935.9803200983956;3955.5055618047745;3965.583613720561;3968;3893.4549163117044;3907.7655340679507;3918.492165014393;3934.822932968009;3941.9211615767667;3833.3291673957224;3912.2762288976346;3915.984691787322;3919.1181984053646;3920.3727403615426;3474.8957531274104;3491.6682915123024;3500.9124771880906;3502.9474557881654;3503.1067077895227;4698.224792909165;4721.315409265671;4727.64542659302;4749.881252968704;4758.738269395182;4358.4769827620885;4382.404481255721;4415.028693687384;4419.602235798793;4499.100179963988;5085.23721441783;5171.844844654666;5173.379194496647;5203.855151866584;5208.531232189083;3771.283456143324;3772.1889793694486;3782.527184101987;3787.715921305913;3800.657940785343;5374.973125134349;5382.4886635769535;5417.322834645669;5430;5448.073827449343;3780.243951209769;3810.961890381116;3828.980855095707;3855.7108216883844;3865.613438656112;3911.3350730375905;3921.176552923918;3932.46911666927;3933.1543718100747;3950.1902110067367;4407.845725399659;4413.889652758707;4415.315626077963;4417.889552761142;4430.980874398906;5031.226580064951;5163.483651634881;5169.663971841818;5195.68825870449;5198.584113270929;1433.6129245103973;1435.9425622975173;1436.3249272841747;1442.834074081494;1443.2711480702178;887.587271918561;963.8883333414639;979.8775153105862;993.8161440133598;995.7759504111661;4489.259272220047;4597.632189424905;4659.487456379796;4668.649851261169;4676.579107880307;5395.865103372447;5396;5411.944670789158;5450.727463626803;5452.182172674131;4473.709208901411;4657.650676199299;4667.789949452283;4676.789544470507;4679.555442232982;3056.190109620952;3064.4024415238814;3071.324308652093;3076.969230307668;3086.4752991991413;5419.539339156216;5423.620346575781;5427.864303392446;5469.56243500519;5473.890522189534;5271.604629652791;5586.664800112007;5642.6614403135945;5881.5882888198275;5902.173695682608;5109.284700141983;5133.563647090039;5165.741712914414;5177.197534382177;5201.713905735221;5404.891902162013;5412.161115027177;5424.484673955968;5444.8094316698725;5484.204790305464;5201.271821944855;5292.9735351323;5295.973520132375;5309.628326017296;5336.146216605324;5127.564157046693;5172.431032586488;5181.171012637959;5202.2196670499725;5224.9738751306;3919.8236079375924;3952.7035472340262;3974.721769476109;3977.284088864032;3978.960210397859;5216.269722238965;5400.757825700032;5413.24214609947;5424.457554244544;5438.564914806727;5230.947690523199;5239.685618862881;5261.184516399964;5266.578673706171;5276.208568714724;4924.285978533164;5162.535371816554;5231.764570594409;5244.606654500852;5248.475152484721;5139.203423469368;5157.020166168416;5174.560162386088;5183.896322073462;5195.74021298926;4954.77703503336;5054.671446355975;5206.661566998133;5215.400228973716;5244.685318880879;5090.592752579711;5106.7957281709805;5125.410577783454;5130.897382052263;5132.948670513247 04:46:10 INFO - PROCESS | 5359 | |5;yui.html;645.2708439463406;667.7395815631904;735.98434160858;764.6291548598929;787.2953706432746;11364.318140911551;12296.5696200633;12341.629751107459;12397.93801030996;12413.441395137217;11933;12289;12364.876351236508;12366.690832729186;12384;632.5414074795759;781.4100354232546;793.468376187954;807.0355924670022;807.588130053671;811.9553424561676;813.1583810755869;815.1685281013363;815.9836803263931;816.1675091406762;856.9357298202659;857.1728282207699;858.047567200407;859;859.2481578618708;848.8090179709516;850.1073872433919;850.3239924260197;850.7873031742096;852.1521086518923;618.6071844378807;619.2785405003166;620.1349117980392;623.3361470034399;624.4348864277836;11732.296062236293;11750.471228794724;11765.764684706259;11845.23006004607;11850.288982661068;12662.683432914251;12674.302913339763;12679.746405071846;12886.80669789954;13181.143225690395;9931.304808663397;10052.296339256254;10126.696199114038;10256.846147307797;10275.92102829207;3319.9834000830083;3339.532465454838;3368.292658541709;3412.368711788327;3437;47325.29012064822;47570;47898;48085;48593.27110093351;8940.776480588038;8998.415103018282;9008.59461324242;9743;9805.068518490732;15718.528444146694;15999.520014399586;16078.678426431406;16119.597010074607;16139.435119770986;6097.908531372033;6141.600795948339;6173.722182501798;6423.068655044993;6471;3636.8363423646;3805.296020236265;3859.9807000964815;3877.728559000899;3916.3146449371247;2722.5507791214623;2801.705820888818;2802.8178168418985;2803.9299017524727;2808.9157325280275;511.6853135321825;522.2505704314322;523.2883278740909;531.4048265942092;536.1502019299376;474.6416455576018;477.33888564337946;489.36138339466623;492.0184232456273;516.4241870314647;6888.345607167311;6942.895856562054;7109.822254443577;7309.488335816548;7329.413646908234;455.3829560944938;478.0439121756487;501.79928028788777;523.3641126031889;528.1444060621817;3248.8375581220844;3248.8700451982127;3262.8531716072357;3303.6035675719068;3310.371029504435;47202.76398617985;51110;52158.739206303726;52302.738486307324;55916.72041639766;47953;48085;48836.755816221405;49498;50090;44018.559814402084;45692.086158276645;46048.309275360894;46686;47056.2941555877;7815.804604884696;7861.921380786119;7875.84248315042;7932.84134317322;7976.521408715495;29774.851125744233;29820;29821;30365.392692146474;30701.692983069883;36174;40175.59824401836;40641.59358406378;40674.1865162701;40807.1838563233;10764;10816.513256903616;10820.729481763019;10878.347299162075;10894.400807955639;11459.255148415326;11986.820197697216;12179.08656850722;12283.324417157142;12350.197237179555;10717.517711702836;11298.265612735146;11315.377654229096;11694.70763230926;11702.180847340604;9821.165200958;10161.542730576994;10297.639582614573;10306;10459;10444;10828.133749300194;11046.502907369348;11248.550057997589;11266.324020558794;9430.858537122085;9537.618495260112;9764.415526138828;10047.296689231684;10124.84812727795;8366.66533338684;8906.109389061043;9116.954415227881;9168.954155229181;9203.907960920305 04:46:10 INFO - PROCESS | 5359 | __end_tp_report 04:46:10 INFO - PROCESS | 5359 | __start_cc_report 04:46:10 INFO - PROCESS | 5359 | _x_x_mozilla_cycle_collect,379 04:46:10 INFO - PROCESS | 5359 | __end_cc_report 04:46:10 INFO - PROCESS | 5359 | __startTimestamp1461757570676__endTimestamp 04:46:10 INFO - PROCESS | 5359 | 04:46:10 INFO - PROCESS | 5359 | ------- Summary: start ------- 04:46:10 INFO - PROCESS | 5359 | Number of tests: 6 04:46:10 INFO - PROCESS | 5359 | 04:46:10 INFO - PROCESS | 5359 | [#0] dojo.html Cycles:165 Average:4683.61 Median:4837.90 stddev:582.38 (12.0%) stddev-sans-first:561.65 04:46:10 INFO - PROCESS | 5359 | Values: 2639.1 2709.1 2723.9 2733.2 2746.1 4743.7 4779.7 4799.7 4802.2 4836.8 4644.7 4741.4 4784.4 4784.4 4871.3 4352.5 4419.6 4420.1 4421.6 4428.5 664.1 4213.1 4281.2 4367.8 4389.2 4368.3 4411.3 4413.8 4421.4 4433.6 4410.5 4413.6 4421.4 4432.0 4452.1 4211.1 4348.5 4375.5 4387.8 4425.9 4721.1 4721.8 4736.1 4738.3 4762.3 5113.8 5147.9 5158.5 5169.3 5174.2 4980.4 5117.3 5195.8 5214.3 5220.1 4732.7 4746.0 4750.0 4765.8 4782.0 5208.2 5214.3 5214.5 5225.7 5266.8 4837.7 4893.1 4939.3 4965.2 4986.8 5071.4 5090.2 5094.4 5102.8 5159.7 4928.9 5034.9 5038.5 5047.0 5048.0 5015.3 5043.1 5053.2 5084.7 5095.3 4183.2 4187.4 4198.9 4224.9 4232.8 3662.9 3700.3 3702.1 3723.3 3758.1 4364.8 4371.8 4420.7 4449.4 4454.5 5059.2 5064.2 5082.8 5148.5 5244.3 4508.3 4521.4 4530.4 4531.3 4567.2 4543.9 4604.0 4616.4 4624.0 4660.8 4749.4 4839.5 4841.3 4841.5 4844.5 5059.4 5096.9 5123.4 5163.1 5174.2 4834.5 4855.3 4863.5 4879.0 4904.1 4933.2 5037.7 5043.7 5074.1 5086.5 5118.8 5132.5 5140.4 5143.8 5173.9 4901.9 4908.8 4910.2 4912.5 4953.4 4831.6 4901.2 4916.7 4938.1 5001.6 4773.3 4795.3 4801.4 4838.0 4869.8 4899.5 4908.9 4920.2 4924.5 4978.6 4756.9 4807.8 4837.9 4871.4 4909.0 04:46:10 INFO - PROCESS | 5359 | 04:46:10 INFO - PROCESS | 5359 | [#1] ext.html Cycles:180 Average:38576.26 Median:34424.33 stddev:60296.99 (175.2%) stddev-sans-first:60398.57 04:46:10 INFO - PROCESS | 5359 | Values: 558.2 577.9 596.1 601.9 634.9 31796.4 32580.3 32602.2 32742.2 32909.5 35799.3 36357.6 36657.3 36756.0 36781.6 7568.1 7720.6 7786.5 7786.9 7787.8 7586.4 7620.5 7678.3 7685.7 7691.9 7662.3 7692.8 7717.2 7730.4 7750.2 7641.8 7660.6 7692.6 7719.2 7723.1 7643.4 7687.5 7697.8 7785.2 7795.3 34414.8 34541.1 34748.7 34788.0 34965.5 3117.7 3299.0 3652.0 3764.1 3858.9 27030.3 27423.3 27716.9 27806.2 27969.3 3452.9 3538.9 3547.2 3561.5 3590.7 179160.0 183983.0 184242.1 185707.0 195185.0 47283.3 47694.0 47836.0 48047.8 48116.0 48806.3 50551.2 50720.0 50936.2 55283.7 13494.5 13718.5 13724.5 13731.2 13737.8 10302.5 10312.5 10312.6 10346.4 10351.5 16650.2 16715.5 16797.7 16813.2 16857.7 6803.2 6822.2 6970.9 6981.0 7220.1 842.6 870.0 895.2 901.6 970.7 26207.5 27235.3 27295.6 27340.5 27655.2 956.3 975.6 978.8 1006.7 1070.8 13365.7 13602.1 13798.7 13946.2 14033.0 269866.0 270842.0 272113.0 273599.0 273927.0 46112.3 46395.0 46701.5 46787.0 46972.0 1238.3 1251.5 1267.1 1269.9 1327.0 24497.7 26133.5 26641.3 26771.0 26839.9 40260.4 40656.6 40698.2 40792.5 40908.6 226981.0 229110.0 229649.0 229667.0 230290.0 24264.5 33273.7 34165.5 34433.8 34626.5 36054.5 36513.0 36605.5 37003.4 37919.2 31514.2 31594.5 31943.7 32843.5 35267.5 33352.3 33483.0 33492.0 34268.7 34666.7 27225.7 31357.0 32111.0 33967.8 34355.0 28341.6 29204.9 29223.7 29346.6 29457.6 22576.9 23120.3 24207.5 24262.9 24703.0 04:46:10 INFO - PROCESS | 5359 | 04:46:10 INFO - PROCESS | 5359 | [#2] jquery.html Cycles:180 Average:20746.92 Median:5099.90 stddev:52490.79 (1029.3%) stddev-sans-first:52615.76 04:46:10 INFO - PROCESS | 5359 | Values: 374.4 379.9 380.3 381.2 382.5 15414.2 15677.5 16110.7 16271.5 16316.2 15264.0 15783.9 16416.3 16426.2 16466.7 4927.1 5045.2 5093.4 5093.8 5098.3 3633.4 5002.3 5428.4 5706.7 5711.9 5597.6 5599.2 5631.8 5632.5 5671.8 5350.5 5766.9 5770.0 5790.9 5793.1 4912.8 5060.0 5101.5 5103.2 5107.3 18857.6 19009.8 19270.9 19394.7 19433.9 1990.7 2023.4 2037.4 2044.7 2052.4 12094.9 12506.9 12632.7 12644.6 12820.3 1761.0 1830.4 1831.7 1832.1 1869.0 54799.7 56788.7 57030.7 57316.0 57646.1 9010.2 9148.4 9474.0 9506.1 9695.0 12785.9 12809.4 12913.4 12985.3 13001.2 7144.6 7355.4 7417.6 7427.1 7494.0 7089.2 7089.6 7187.5 7189.7 7275.2 5903.2 5904.4 5941.1 5958.9 6121.8 1609.3 1701.2 1792.5 1833.1 1864.0 818.7 922.5 948.4 967.1 999.2 14876.8 15003.0 15155.5 15220.8 15405.2 889.5 904.9 914.7 923.9 962.3 9391.3 9429.4 9430.9 9479.9 9584.8 284579.0 289735.0 291999.0 351906.2 370848.0 44540.8 45103.5 45497.3 66065.3 70120.0 918.5 940.0 945.2 950.7 960.0 14378.6 14752.0 14830.8 14847.8 15021.6 23996.5 27682.7 32698.2 32829.3 32835.0 40365.4 43859.6 44036.8 44639.3 45172.5 7167.3 7178.2 7186.3 7430.2 7580.8 9523.8 10886.7 11010.9 11158.4 11189.0 9047.8 9256.5 9563.1 9668.4 9765.4 9551.4 9567.0 9628.9 9900.7 10094.2 5154.9 8311.9 9484.3 10059.2 10128.6 7210.9 7345.2 7418.6 7531.7 7564.9 9864.3 9878.2 9930.2 10007.7 10092.0 04:46:10 INFO - PROCESS | 5359 | 04:46:10 INFO - PROCESS | 5359 | [#3] mootools.html Cycles:180 Average:4671.88 Median:5588.67 stddev:2407.87 (43.1%) stddev-sans-first:2402.16 04:46:10 INFO - PROCESS | 5359 | Values: 1412.2 1434.2 1540.3 1684.5 1718.6 6326.4 6692.8 6725.3 6942.5 6957.8 6672.6 6706.1 6741.7 6761.0 6788.3 2127.5 2179.6 2182.8 2184.4 2189.1 2105.3 2136.2 2156.4 2162.7 2168.3 2139.5 2156.6 2161.5 2163.1 2188.5 2121.1 2133.7 2133.8 2136.0 2141.4 2097.4 2190.2 2190.7 2193.6 2198.1 6946.7 7009.8 7026.8 7040.8 7043.7 4366.3 4471.5 4495.9 4496.8 4500.8 2727.8 2762.7 2849.2 2851.5 2872.9 893.6 920.2 928.5 949.7 963.1 8901.4 8915.7 8964.3 8983.2 9000.7 4112.3 4157.5 4207.1 4264.5 4271.4 7919.5 7925.8 7955.9 7978.0 7980.2 4503.9 4524.8 4550.3 4551.6 4564.2 3559.1 3988.9 4108.7 4131.0 4163.5 3486.5 3561.6 3581.9 3585.7 3655.3 1195.1 1201.7 1208.6 1232.0 1233.3 744.0 761.1 792.6 878.9 899.9 4756.0 4920.7 4941.1 4975.5 5056.7 832.6 856.2 857.6 871.9 911.4 3436.1 3450.6 3501.2 3537.7 3568.0 7928.8 8134.6 8151.0 8182.5 8239.1 8282.4 8330.3 8340.6 8363.3 8387.4 6591.7 6602.4 6644.6 6654.8 6704.3 4574.0 4733.4 4737.7 4738.7 4775.9 7764.0 7813.5 7888.8 7921.8 7962.4 7841.8 7870.6 7930.5 7959.1 8036.2 5459.4 5718.0 5798.8 5928.7 5985.6 6599.9 6607.0 6627.4 6650.1 6674.4 6099.1 6100.5 6213.3 6280.5 6284.5 5894.9 5981.1 6012.5 6078.4 6088.0 5725.8 5777.6 5792.9 5800.2 5806.5 4062.5 4177.0 4217.6 4306.6 4310.0 4315.3 4324.5 4418.6 4429.0 4470.8 04:46:10 INFO - PROCESS | 5359 | 04:46:10 INFO - PROCESS | 5359 | [#4] prototype.html Cycles:180 Average:4378.30 Median:4929.32 stddev:1247.77 (25.3%) stddev-sans-first:1213.27 04:46:10 INFO - PROCESS | 5359 | Values: 306.5 313.7 313.8 315.4 319.0 4934.4 5000.0 5004.2 5007.6 5007.7 4868.2 4874.7 4901.1 4903.7 4907.9 3701.4 3780.3 3891.1 3919.8 3920.3 3912.4 3936.0 3955.5 3965.6 3968.0 3893.5 3907.8 3918.5 3934.8 3941.9 3833.3 3912.3 3916.0 3919.1 3920.4 3474.9 3491.7 3500.9 3502.9 3503.1 4698.2 4721.3 4727.6 4749.9 4758.7 4358.5 4382.4 4415.0 4419.6 4499.1 5085.2 5171.8 5173.4 5203.9 5208.5 3771.3 3772.2 3782.5 3787.7 3800.7 5375.0 5382.5 5417.3 5430.0 5448.1 3780.2 3811.0 3829.0 3855.7 3865.6 3911.3 3921.2 3932.5 3933.2 3950.2 4407.8 4413.9 4415.3 4417.9 4431.0 5031.2 5163.5 5169.7 5195.7 5198.6 1433.6 1435.9 1436.3 1442.8 1443.3 887.6 963.9 979.9 993.8 995.8 4489.3 4597.6 4659.5 4668.6 4676.6 5395.9 5396.0 5411.9 5450.7 5452.2 4473.7 4657.7 4667.8 4676.8 4679.6 3056.2 3064.4 3071.3 3077.0 3086.5 5419.5 5423.6 5427.9 5469.6 5473.9 5271.6 5586.7 5642.7 5881.6 5902.2 5109.3 5133.6 5165.7 5177.2 5201.7 5404.9 5412.2 5424.5 5444.8 5484.2 5201.3 5293.0 5296.0 5309.6 5336.1 5127.6 5172.4 5181.2 5202.2 5225.0 3919.8 3952.7 3974.7 3977.3 3979.0 5216.3 5400.8 5413.2 5424.5 5438.6 5230.9 5239.7 5261.2 5266.6 5276.2 4924.3 5162.5 5231.8 5244.6 5248.5 5139.2 5157.0 5174.6 5183.9 5195.7 4954.8 5054.7 5206.7 5215.4 5244.7 5090.6 5106.8 5125.4 5130.9 5132.9 04:46:10 INFO - PROCESS | 5359 | 04:46:10 INFO - PROCESS | 5359 | [#5] yui.html Cycles:180 Average:12875.04 Median:47129.53 stddev:14982.04 (31.8%) stddev-sans-first:14995.92 04:46:10 INFO - PROCESS | 5359 | Values: 645.3 667.7 736.0 764.6 787.3 11364.3 12296.6 12341.6 12397.9 12413.4 11933.0 12289.0 12364.9 12366.7 12384.0 632.5 781.4 793.5 807.0 807.6 812.0 813.2 815.2 816.0 816.2 856.9 857.2 858.0 859.0 859.2 848.8 850.1 850.3 850.8 852.2 618.6 619.3 620.1 623.3 624.4 11732.3 11750.5 11765.8 11845.2 11850.3 12662.7 12674.3 12679.7 12886.8 13181.1 9931.3 10052.3 10126.7 10256.8 10275.9 3320.0 3339.5 3368.3 3412.4 3437.0 47325.3 47570.0 47898.0 48085.0 48593.3 8940.8 8998.4 9008.6 9743.0 9805.1 15718.5 15999.5 16078.7 16119.6 16139.4 6097.9 6141.6 6173.7 6423.1 6471.0 3636.8 3805.3 3860.0 3877.7 3916.3 2722.6 2801.7 2802.8 2803.9 2808.9 511.7 522.3 523.3 531.4 536.2 474.6 477.3 489.4 492.0 516.4 6888.3 6942.9 7109.8 7309.5 7329.4 455.4 478.0 501.8 523.4 528.1 3248.8 3248.9 3262.9 3303.6 3310.4 47202.8 51110.0 52158.7 52302.7 55916.7 47953.0 48085.0 48836.8 49498.0 50090.0 44018.6 45692.1 46048.3 46686.0 47056.3 7815.8 7861.9 7875.8 7932.8 7976.5 29774.9 29820.0 29821.0 30365.4 30701.7 36174.0 40175.6 40641.6 40674.2 40807.2 10764.0 10816.5 10820.7 10878.3 10894.4 11459.3 11986.8 12179.1 12283.3 12350.2 10717.5 11298.3 11315.4 11694.7 11702.2 9821.2 10161.5 10297.6 10306.0 10459.0 10444.0 10828.1 11046.5 11248.6 11266.3 9430.9 9537.6 9764.4 10047.3 10124.8 8366.7 8906.1 9117.0 9169.0 9203.9 04:46:10 INFO - PROCESS | 5359 | -------- Summary: end -------- 04:46:10 INFO - PROCESS | 5359 | 04:46:11 INFO - TEST-INFO | 5359: exit 0 04:46:11 INFO - TEST-OK | dromaeo_css | took 1116075ms 04:46:11 INFO - TEST-START | kraken 04:46:11 INFO - operating with platform_type : linux_ 04:46:11 INFO - Initialising browser for kraken test... 04:46:11 INFO - TEST-INFO | started process 5591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFsmtA/profile http://localhost:37639/getInfo.html) 04:46:15 INFO - PROCESS | 5591 | 04:46:15 INFO - PROCESS | 5591 | (process:5659): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:46:16 INFO - PROCESS | 5591 | __metrics Screen width/height:1600/1200 04:46:16 INFO - PROCESS | 5591 | colorDepth:24 04:46:16 INFO - PROCESS | 5591 | Browser inner width/height: 1024/697 04:46:16 INFO - PROCESS | 5591 | __metrics 04:46:17 ERROR - PROCESS | 5591 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:46:18 INFO - TEST-INFO | 5591: exit 0 04:46:18 INFO - Browser initialized. 04:46:18 INFO - Running cycle 1/1 for kraken test... 04:46:18 INFO - TEST-INFO | started process 5710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFsmtA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:20 INFO - PROCESS | 5710 | 04:46:20 INFO - PROCESS | 5710 | (process:5772): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:46:30 INFO - PROCESS | 5710 | RSS: Main: 165888000 04:46:30 INFO - PROCESS | 5710 | 04:46:32 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37639/tests/kraken/driver.html?testName=audio-beat-detection) 04:46:33 INFO - PROCESS | 5710 | RSS: Main: 170508288 04:46:33 INFO - PROCESS | 5710 | 04:46:36 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37639/tests/kraken/driver.html?testName=audio-dft) 04:46:37 INFO - PROCESS | 5710 | RSS: Main: 173785088 04:46:37 INFO - PROCESS | 5710 | 04:46:40 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37639/tests/kraken/driver.html?testName=audio-fft) 04:46:40 INFO - PROCESS | 5710 | RSS: Main: 164298752 04:46:40 INFO - PROCESS | 5710 | 04:46:42 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37639/tests/kraken/driver.html?testName=audio-oscillator) 04:46:43 INFO - PROCESS | 5710 | RSS: Main: 165208064 04:46:43 INFO - PROCESS | 5710 | 04:46:45 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37639/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:46:46 INFO - PROCESS | 5710 | RSS: Main: 165683200 04:46:46 INFO - PROCESS | 5710 | 04:46:49 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37639/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:50 INFO - PROCESS | 5710 | RSS: Main: 166064128 04:46:50 INFO - PROCESS | 5710 | 04:46:53 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37639/tests/kraken/driver.html?testName=imaging-desaturate) 04:46:54 INFO - PROCESS | 5710 | RSS: Main: 165978112 04:46:54 INFO - PROCESS | 5710 | 04:46:57 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37639/tests/kraken/driver.html?testName=json-parse-financial) 04:46:57 INFO - PROCESS | 5710 | RSS: Main: 166608896 04:46:57 INFO - PROCESS | 5710 | 04:46:59 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37639/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:00 INFO - PROCESS | 5710 | RSS: Main: 167469056 04:47:00 INFO - PROCESS | 5710 | 04:47:02 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:02 INFO - PROCESS | 5710 | RSS: Main: 167153664 04:47:02 INFO - PROCESS | 5710 | 04:47:04 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:05 INFO - PROCESS | 5710 | RSS: Main: 167190528 04:47:05 INFO - PROCESS | 5710 | 04:47:08 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:09 INFO - PROCESS | 5710 | RSS: Main: 167317504 04:47:09 INFO - PROCESS | 5710 | 04:47:12 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:13 INFO - PROCESS | 5710 | RSS: Main: 164859904 04:47:13 INFO - PROCESS | 5710 | 04:47:14 INFO - PROCESS | 5710 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37639/tests/kraken/driver.html?testName=ai-astar) 04:47:15 INFO - PROCESS | 5710 | RSS: Main: 166817792 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | __start_tp_report 04:47:15 INFO - PROCESS | 5710 | _x_x_mozilla_page_load 04:47:15 INFO - PROCESS | 5710 | _x_x_mozilla_page_load_details 04:47:15 INFO - PROCESS | 5710 | |i|pagename|runs| 04:47:15 INFO - PROCESS | 5710 | |0;ai-astar;117;109;115;113;113;125;115;114;115;114 04:47:15 INFO - PROCESS | 5710 | |1;audio-beat-detection;162;135;157;185;138;165;156;144;196;134 04:47:15 INFO - PROCESS | 5710 | |2;audio-dft;162;162;165;176;163;163;166;163;174;162 04:47:15 INFO - PROCESS | 5710 | |3;audio-fft;73;74;73;177;75;74;77;75;159;74 04:47:15 INFO - PROCESS | 5710 | |4;audio-oscillator;95;95;148;94;94;94;150;94;93;149 04:47:15 INFO - PROCESS | 5710 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;117;118;117 04:47:15 INFO - PROCESS | 5710 | |6;imaging-darkroom;149;147;147;148;149;148;148;147;148;147 04:47:15 INFO - PROCESS | 5710 | |7;imaging-desaturate;96;97;95;95;96;95;95;95;96;96 04:47:15 INFO - PROCESS | 5710 | |8;json-parse-financial;64;65;65;63;65;65;67;81;63;64 04:47:15 INFO - PROCESS | 5710 | |9;json-stringify-tinderbox;65;65;64;64;65;66;64;66;65;71 04:47:15 INFO - PROCESS | 5710 | |10;stanford-crypto-aes;79;88;78;81;82;82;83;80;81;81 04:47:15 INFO - PROCESS | 5710 | |11;stanford-crypto-ccm;147;139;134;141;134;139;141;149;172;142 04:47:15 INFO - PROCESS | 5710 | |12;stanford-crypto-pbkdf2;217;220;227;217;218;214;214;217;218;212 04:47:15 INFO - PROCESS | 5710 | |13;stanford-crypto-sha256-iterative;77;76;75;77;76;73;79;76;75;80 04:47:15 INFO - PROCESS | 5710 | __end_tp_report 04:47:15 INFO - PROCESS | 5710 | __start_cc_report 04:47:15 INFO - PROCESS | 5710 | _x_x_mozilla_cycle_collect,915 04:47:15 INFO - PROCESS | 5710 | __end_cc_report 04:47:15 INFO - PROCESS | 5710 | __startTimestamp1461757635243__endTimestamp 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | ------- Summary: start ------- 04:47:15 INFO - PROCESS | 5710 | Number of tests: 14 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:4.08 (3.5%) stddev-sans-first:4.27 04:47:15 INFO - PROCESS | 5710 | Values: 117.0 109.0 115.0 113.0 113.0 125.0 115.0 114.0 115.0 114.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#1] audio-beat-detection Cycles:10 Average:157.20 Median:159.50 stddev:20.92 (13.1%) stddev-sans-first:22.11 04:47:15 INFO - PROCESS | 5710 | Values: 162.0 135.0 157.0 185.0 138.0 165.0 156.0 144.0 196.0 134.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.00 stddev:5.15 (3.1%) stddev-sans-first:5.29 04:47:15 INFO - PROCESS | 5710 | Values: 162.0 162.0 165.0 176.0 163.0 163.0 166.0 163.0 174.0 162.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#3] audio-fft Cycles:10 Average:93.10 Median:74.00 stddev:39.72 (53.7%) stddev-sans-first:41.46 04:47:15 INFO - PROCESS | 5710 | Values: 73.0 74.0 73.0 177.0 75.0 74.0 77.0 75.0 159.0 74.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:94.00 stddev:26.51 (28.2%) stddev-sans-first:27.51 04:47:15 INFO - PROCESS | 5710 | Values: 95.0 95.0 148.0 94.0 94.0 94.0 150.0 94.0 93.0 149.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:47:15 INFO - PROCESS | 5710 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 04:47:15 INFO - PROCESS | 5710 | Values: 149.0 147.0 147.0 148.0 149.0 148.0 148.0 147.0 148.0 147.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:47:15 INFO - PROCESS | 5710 | Values: 96.0 97.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:65.00 stddev:5.33 (8.2%) stddev-sans-first:5.59 04:47:15 INFO - PROCESS | 5710 | Values: 64.0 65.0 65.0 63.0 65.0 65.0 67.0 81.0 63.0 64.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:2.07 (3.2%) stddev-sans-first:2.19 04:47:15 INFO - PROCESS | 5710 | Values: 65.0 65.0 64.0 64.0 65.0 66.0 64.0 66.0 65.0 71.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:2.72 (3.3%) stddev-sans-first:2.73 04:47:15 INFO - PROCESS | 5710 | Values: 79.0 88.0 78.0 81.0 82.0 82.0 83.0 80.0 81.0 81.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:141.50 stddev:11.00 (7.8%) stddev-sans-first:11.61 04:47:15 INFO - PROCESS | 5710 | Values: 147.0 139.0 134.0 141.0 134.0 139.0 141.0 149.0 172.0 142.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:217.40 Median:217.50 stddev:4.12 (1.9%) stddev-sans-first:4.36 04:47:15 INFO - PROCESS | 5710 | Values: 217.0 220.0 227.0 217.0 218.0 214.0 214.0 217.0 218.0 212.0 04:47:15 INFO - PROCESS | 5710 | 04:47:15 INFO - PROCESS | 5710 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:76.50 stddev:2.01 (2.6%) stddev-sans-first:2.12 04:47:15 INFO - PROCESS | 5710 | Values: 77.0 76.0 75.0 77.0 76.0 73.0 79.0 76.0 75.0 80.0 04:47:15 INFO - PROCESS | 5710 | -------- Summary: end -------- 04:47:15 INFO - PROCESS | 5710 | 04:47:16 INFO - TEST-INFO | 5710: exit 0 04:47:16 INFO - TEST-OK | kraken | took 64908ms 04:47:16 INFO - SUITE-END | took 1180s 04:47:16 INFO - Completed test suite (00:19:40) 04:47:16 INFO - javascript benchmark 04:47:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.0631325879312, 2709.0924540279007, 2723.8774255158514, 2733.1663842528033, 2746.093789049614, 4743.691660042099, 4779.71321720697, 4799.712017278957, 4802.1836287831065, 4836.806527738886, 4644.744539050351, 4741.431028276603, 4784.378030855993, 4784.44978827435, 4871.293662418947, 4352.499462561798, 4419.558044195587, 4420.07178492517, 4421.624161946223, 4428.512863585003, 664.0886687721312, 4213.115245798386, 4281.207976524337, 4367.759773212472, 4389.23188442023, 4368.322909948963, 4411.338299255105, 4413.801378937956, 4421.358902959069, 4433.578810013044, 4410.514843367227, 4413.580709832593, 4421.403110580062, 4432.024954510002, 4452.109578084363, 4211.115665710205, 4348.4999225089205, 4375.453068366454, 4387.780610969438, 4425.911481770347, 4721.102990431807, 4721.811127554894, 4736.147493451177, 4738.312944623045, 4762.28565715142, 5113.846584602431, 5147.897042059138, 5158.484151584849, 5169.2504586835075, 5174.249733788617, 4980.402351717781, 5117.257997590328, 5195.844124676266, 5214.270002199657, 5220.086484865134, 4732.692374995683, 4746.003339298717, 4749.952500474986, 4765.833195838164, 4781.971876046667, 5208.166693329049, 5214.348206474191, 5214.504622060898, 5225.686458812484, 5266.815661451831, 4837.733924634109, 4893.119238537098, 4939.3084968104495, 4965.230389289666, 4986.750662466935, 5071.442141364447, 5090.211017292251, 5094.439611642716, 5102.846914592568, 5159.74201289934, 4928.8767780805765, 5034.924476132861, 5038.496150385005, 5046.9747651261505, 5047.97476012625, 5015.3229314042865, 5043.142665746832, 5053.166227572483, 5084.669496482717, 5095.337606111256, 4183.226103170923, 4187.392828039917, 4198.9370159447635, 4224.8732538023905, 4232.830686772495, 3662.8901132966053, 3700.296943580765, 3702.129999450127, 3723.255348930225, 3758.0980564664283, 4364.8472303469225, 4371.78141092944, 4420.734755914656, 4449.443819522559, 4454.510003899569, 5059.215821547666, 5064.240363945438, 5082.822101226439, 5148.485151484896, 5244.318238628954, 4508.301213311942, 4521.367008618796, 4530.4110465639915, 4531.297648864432, 4567.177907976529, 4543.909121817611, 4603.976980115078, 4616.3537104805355, 4623.976880115578, 4660.790264438108, 4749.35883655702, 4839.467658557556, 4841.273808928689, 4841.491643377394, 4844.515548445127, 5059.418166910705, 5096.923546146885, 5123.410807757155, 5163.148080566664, 5174.197999310113, 4834.492378300228, 4855.320255164209, 4863.513648635108, 4879.0, 4904.141775189399, 4933.186024305949, 5037.672551284155, 5043.672161309503, 5074.11203039474, 5086.465921078381, 5118.795248190179, 5132.486751324837, 5140.4088529818055, 5143.8456846294675, 5173.896522069613, 4901.9264711028645, 4908.828191013297, 4910.165271903714, 4912.533309335608, 4953.430355509163, 4831.613470922248, 4901.240307752304, 4916.70499770015, 4938.1358262304675, 5001.57486613642, 4773.284007398779, 4795.256735206049, 4801.399825021872, 4837.975810120927, 4869.756512174448, 4899.485554016919, 4908.901821963469, 4920.21276595743, 4924.482929292372, 4978.601711863114, 4756.857294281177, 4807.759612019455, 4837.903241935212, 4871.415430148405, 4909.018196360814], "value": 4648.627831848512, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.1865743487014, 577.9393163717809, 596.0552524249063, 601.888650599639, 634.898416253399, 31796.36407271853, 32580.348393032124, 32602.184945376317, 32742.181445463844, 32909.50635740466, 35799.284014319695, 36357.63642363582, 36657.26685466296, 36756.0, 36781.63218367816, 7568.09182898053, 7720.61396930154, 7786.532808031508, 7786.922130778677, 7787.844243115134, 7586.431017673696, 7620.466567340289, 7678.347340476066, 7685.692572297129, 7691.884621730678, 7662.310392064713, 7692.807679808022, 7717.151113377524, 7730.420218483636, 7750.186230445806, 7641.808954776147, 7660.578668173248, 7692.576908270043, 7719.189485104067, 7723.0732312122345, 7643.350315223212, 7687.500312479671, 7697.846043079163, 7785.182555831613, 7795.33739632132, 34414.82792586046, 34541.13647158816, 34748.65251347479, 34788.0, 34965.475517866995, 3117.688231176887, 3299.0, 3652.0213699067103, 3764.0966168119726, 3858.8649397271242, 27030.32424189391, 27423.314417139532, 27716.861415692994, 27806.165815025583, 27969.300767480774, 3452.896413107611, 3538.929221415583, 3547.2373439710327, 3561.51919490868, 3590.694790942773, 179160.0, 183983.0, 184242.07878960654, 185707.0, 195185.0, 47283.29075063877, 47694.0, 47836.0, 48047.75976120097, 48116.0, 48806.26790598144, 50551.24173137406, 50719.985600287786, 50936.23595646068, 55283.72358138183, 13494.52769153075, 13718.451261949609, 13724.519641812689, 13731.244781536912, 13737.793933091012, 10302.536385862504, 10312.484375781181, 10312.639057633098, 10346.37921724699, 10351.482425878676, 16650.16749162537, 16715.498535043967, 16797.664046718997, 16813.243404046847, 16857.747133793004, 6803.217629972616, 6822.249552549216, 6970.860582788316, 6981.0, 7220.133583969852, 842.6292431330195, 869.9869501957476, 895.1943251073956, 901.6032945503957, 970.7281961050917, 26207.475850483264, 27235.319117022234, 27295.590566141524, 27340.45319093607, 27655.170344889684, 956.2923436656963, 975.5805003848271, 978.7553111722069, 1006.6577363696379, 1070.7757895103896, 13365.732685346238, 13602.115862468909, 13798.65503362404, 13946.16323020622, 14033.0, 269866.0, 270842.0, 272113.0, 273599.0, 273927.0, 46112.308315375296, 46395.0, 46701.53298466972, 46787.0, 46972.0, 1238.2632333761399, 1251.4868903749418, 1267.0687045021903, 1269.9111062225556, 1327.0378975242872, 24497.65262910557, 26133.477330452904, 26641.33396665099, 26771.0, 26839.865800670872, 40260.39609405803, 40656.59343406646, 40698.186036278516, 40792.53263472638, 40908.59091409167, 226981.0, 229110.0, 229649.0, 229667.0, 230290.0, 24264.51470970606, 33273.66726332706, 34165.487517687754, 34433.82783086068, 34626.48060279048, 36054.4591831128, 36513.0, 36605.450918235714, 37003.44494832526, 37919.24161516699, 31514.212144696565, 31594.52608210833, 31943.68056319407, 32843.50734739029, 35267.47098793572, 33352.33295334128, 33483.0, 33492.0, 34268.65731342655, 34666.65333346735, 27225.69099025671, 31357.0, 32111.0, 33967.83016084904, 34355.0, 28341.574876377283, 29204.853975729984, 29223.73972684937, 29346.559801602565, 29457.55813662754, 22576.887115564317, 23120.306390808302, 24207.51584968326, 24262.878685606458, 24703.0], "value": 16482.294208308882, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.4121728885649, 379.8575534174685, 380.30024754451813, 381.1690514678003, 382.5371300726121, 15414.152221627806, 15677.529674109766, 16110.677786444265, 16271.51185464438, 16316.184190790473, 15264.0, 15783.92108039461, 16416.261268242928, 16426.17869106543, 16466.670666586662, 4927.1377508935975, 5045.192769156935, 5093.414257360396, 5093.821716239932, 5098.337216161894, 3633.382325004742, 5002.324686167375, 5428.4028756836915, 5706.657600543981, 5711.857203569903, 5597.63615365002, 5599.216109744639, 5631.8028868989595, 5632.549396048326, 5671.829845104633, 5350.5184533391985, 5766.88466230673, 5770.04794208955, 5790.913136302959, 5793.13103034544, 4912.803487860481, 5060.0, 5101.464346243628, 5103.157978933508, 5107.259447380146, 18857.62284754311, 19009.809901900942, 19270.90364548168, 19394.709079363678, 19433.9028304859, 1990.741203643517, 2023.4030960866432, 2037.4397040813747, 2044.7137400763904, 2052.445839623308, 12094.939525302318, 12506.937465312707, 12632.68418289541, 12644.62066138008, 12820.294883781387, 1760.9823901760947, 1830.4142674344216, 1831.716084006981, 1832.1388947194798, 1868.9719654205198, 54799.72600137014, 56788.71605641946, 57030.7148464255, 57316.0, 57646.13530797041, 9010.189082982562, 9148.405353652124, 9473.952630236805, 9506.096920792514, 9694.951525242328, 12785.872141278654, 12809.359532023362, 12913.354332283348, 12985.28580928039, 13001.15492492985, 7144.642767861586, 7355.411567074621, 7417.629118544051, 7427.108746950401, 7493.962530187314, 7089.22018577956, 7089.574625522485, 7187.532810367309, 7189.7483588074165, 7275.236100209508, 5903.203067585907, 5904.439078287642, 5941.1088336749835, 5958.940410595926, 6121.846953826101, 1609.2919115589104, 1701.19193383142, 1792.5160206744106, 1833.092619153501, 1863.990680046591, 818.6807145213371, 922.5295099499169, 948.3977674176947, 967.1150896929372, 999.1656966432964, 14876.776848347283, 15003.0, 15155.469558565397, 15220.847791521943, 15405.152716600694, 889.5285498685707, 904.9185573298435, 914.6798620482778, 923.8891333040078, 962.3456049886005, 9391.342606017513, 9429.387089839138, 9430.858537121949, 9479.857802132974, 9584.808303833885, 284579.0, 289735.0, 291999.0, 351906.2023449383, 370848.0, 44540.77729611331, 45103.54896451059, 45497.31754023692, 66065.33934660592, 70120.0, 918.4581097152712, 939.9718008459757, 945.2107490245722, 950.7290422229631, 959.9808003839884, 14378.640533986734, 14752.0, 14830.777538336717, 14847.777283340974, 15021.624459388602, 23996.480369560944, 27682.723172768016, 32698.182545435604, 32829.34341313112, 32835.0, 40365.39451908165, 43859.561404385546, 44036.779816100716, 44639.330410044524, 45172.548274516834, 7167.319104685047, 7178.174509931425, 7186.281371862772, 7430.219826918312, 7580.824972129329, 9523.809523809623, 10886.67339979802, 11010.944945275221, 11158.442077896236, 11189.04893084097, 9047.773805654911, 9256.49089300095, 9563.139317461462, 9668.419894806335, 9765.365251258645, 9551.379160354554, 9567.0, 9628.855567166638, 9900.653477128266, 10094.19246460296, 5154.896902061862, 8311.916880831357, 9484.340240457754, 10059.19526437898, 10128.59485620567, 7210.89183662256, 7345.1553071397475, 7418.591977441292, 7531.736389226351, 7564.924350756422, 9864.260180486348, 9878.209743220381, 9930.205583553154, 10007.699769006942, 10092.0], "value": 7938.644187804891, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1412.1668215752707, 1434.2183509987058, 1540.252977306007, 1684.5451728033424, 1718.6390857919844, 6326.398992095744, 6692.832679183023, 6725.293844146356, 6942.5073609174015, 6957.826054348644, 6672.633005184713, 6706.094677218574, 6741.66291685415, 6760.96619516903, 6788.287229840869, 2127.5425783456553, 2179.6294629912954, 2182.8144607708364, 2184.377452426059, 2189.069645400706, 2105.2947262667026, 2136.241634219853, 2156.3746513511064, 2162.686410470481, 2168.349495151448, 2139.5079131799694, 2156.6010288096672, 2161.459635091227, 2163.1455575047926, 2188.518525924294, 2121.087932189158, 2133.7012818205385, 2133.7546182189094, 2135.9679604805942, 2141.3575927221927, 2097.4022403614895, 2190.233418303597, 2190.726159230096, 2193.605151072806, 2198.1427243375097, 6946.72213111475, 7009.754658586925, 7026.789196324118, 7040.788776336718, 7043.718251269943, 4366.279563871957, 4471.5081341052455, 4495.910081798378, 4496.842610508649, 4500.819967201308, 2727.8226915250443, 2762.709915458888, 2849.173739615509, 2851.5294976328883, 2872.8994485192916, 893.5576889439769, 920.1994264989502, 928.535732133933, 949.7245798718363, 963.0658261486348, 8901.376903616685, 8915.73252802417, 8964.282857371394, 8983.191512763817, 9000.684976025808, 4112.342025276002, 4157.521884983205, 4207.0954744729415, 4264.488261408589, 4271.444712187395, 7919.524828510308, 7925.801854953672, 7955.920440795518, 7978.042634883851, 7980.162082981319, 4503.887402814956, 4524.8416305429155, 4550.294704320836, 4551.613112885376, 4564.178447879347, 3559.14580500678, 3988.920221595552, 4108.712390132662, 4130.958690413057, 4163.458750362433, 3486.459598762196, 3561.6438356164695, 3581.8746343877838, 3585.731070169748, 3655.3420384331075, 1195.0618764270007, 1201.6515210588832, 1208.5951206345796, 1232.034904327596, 1233.3278363292027, 743.9739609113655, 761.13611051457, 792.631426386733, 878.9208971192623, 899.8605216191501, 4756.048790241965, 4920.6555541111775, 4941.061198372297, 4975.527324904128, 5056.68526183195, 832.5795473285951, 856.1609622569916, 857.5926434943477, 871.9215270625674, 911.3939230411702, 3436.1409647588102, 3450.585929688403, 3501.2122272488486, 3537.663921927413, 3567.982160089183, 7928.801779955432, 8134.59327033646, 8151.0, 8182.509049457051, 8239.052508961546, 8282.420230583923, 8330.333573314121, 8340.62467188978, 8363.289120424832, 8387.412881098386, 6591.670416479157, 6602.372774586406, 6644.568103073285, 6654.800355989328, 6704.3295670433545, 4573.954260457486, 4733.431988161443, 4737.692050016738, 4738.691985020962, 4775.904481910273, 7763.961180194063, 7813.453058285865, 7888.84222315562, 7921.762347129596, 7962.402819788424, 7841.764747057598, 7870.606469676608, 7930.524168549906, 7959.124496305286, 8036.156203598538, 5459.372172200089, 5717.971410142923, 5798.768049277982, 5928.703564821828, 5985.640861548147, 6599.934000660124, 6607.0, 6627.436667883284, 6650.135482387453, 6674.365935236145, 6099.054646529795, 6100.481459076028, 6213.285472170758, 6280.466160376419, 6284.465820405317, 5894.941050589439, 5981.132735753378, 6012.549058820518, 6078.361772014052, 6088.0, 5725.799597014085, 5777.566682498746, 5792.94207057924, 5800.158976948234, 5806.535477161901, 4062.532808727034, 4176.9791151045265, 4217.599328063829, 4306.569343065794, 4309.956900430955, 4315.3095504719095, 4324.524302326805, 4418.645207902641, 4429.047754732748, 4470.798814053311], "value": 3879.525672170082, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.47898572426874, 313.687880558844, 313.8415100374311, 315.44954055173724, 318.9553462515247, 4934.3585333906585, 4999.950000499994, 5004.174311238646, 5007.599392048636, 5007.724575148365, 4868.196747536652, 4874.6831455955335, 4901.1177987962155, 4903.730294833783, 4907.8773030674165, 3701.426278926764, 3780.3006443807844, 3891.0544727636184, 3919.823607937635, 3920.3335432976464, 3912.354461513861, 3935.9803200983956, 3955.5055618047745, 3965.583613720561, 3968.0, 3893.4549163117044, 3907.7655340679507, 3918.492165014393, 3934.822932968009, 3941.9211615767667, 3833.3291673957224, 3912.2762288976346, 3915.984691787322, 3919.1181984053646, 3920.3727403615426, 3474.8957531274104, 3491.6682915123024, 3500.9124771880906, 3502.9474557881654, 3503.1067077895227, 4698.224792909165, 4721.315409265671, 4727.64542659302, 4749.881252968704, 4758.738269395182, 4358.4769827620885, 4382.404481255721, 4415.028693687384, 4419.602235798793, 4499.100179963988, 5085.23721441783, 5171.844844654666, 5173.379194496647, 5203.855151866584, 5208.531232189083, 3771.283456143324, 3772.1889793694486, 3782.527184101987, 3787.715921305913, 3800.657940785343, 5374.973125134349, 5382.4886635769535, 5417.322834645669, 5430.0, 5448.073827449343, 3780.243951209769, 3810.961890381116, 3828.980855095707, 3855.7108216883844, 3865.613438656112, 3911.3350730375905, 3921.176552923918, 3932.46911666927, 3933.1543718100747, 3950.1902110067367, 4407.845725399659, 4413.889652758707, 4415.315626077963, 4417.889552761142, 4430.980874398906, 5031.226580064951, 5163.483651634881, 5169.663971841818, 5195.68825870449, 5198.584113270929, 1433.6129245103973, 1435.9425622975173, 1436.3249272841747, 1442.834074081494, 1443.2711480702178, 887.587271918561, 963.8883333414639, 979.8775153105862, 993.8161440133598, 995.7759504111661, 4489.259272220047, 4597.632189424905, 4659.487456379796, 4668.649851261169, 4676.579107880307, 5395.865103372447, 5396.0, 5411.944670789158, 5450.727463626803, 5452.182172674131, 4473.709208901411, 4657.650676199299, 4667.789949452283, 4676.789544470507, 4679.555442232982, 3056.190109620952, 3064.4024415238814, 3071.324308652093, 3076.969230307668, 3086.4752991991413, 5419.539339156216, 5423.620346575781, 5427.864303392446, 5469.56243500519, 5473.890522189534, 5271.604629652791, 5586.664800112007, 5642.6614403135945, 5881.5882888198275, 5902.173695682608, 5109.284700141983, 5133.563647090039, 5165.741712914414, 5177.197534382177, 5201.713905735221, 5404.891902162013, 5412.161115027177, 5424.484673955968, 5444.8094316698725, 5484.204790305464, 5201.271821944855, 5292.9735351323, 5295.973520132375, 5309.628326017296, 5336.146216605324, 5127.564157046693, 5172.431032586488, 5181.171012637959, 5202.2196670499725, 5224.9738751306, 3919.8236079375924, 3952.7035472340262, 3974.721769476109, 3977.284088864032, 3978.960210397859, 5216.269722238965, 5400.757825700032, 5413.24214609947, 5424.457554244544, 5438.564914806727, 5230.947690523199, 5239.685618862881, 5261.184516399964, 5266.578673706171, 5276.208568714724, 4924.285978533164, 5162.535371816554, 5231.764570594409, 5244.606654500852, 5248.475152484721, 5139.203423469368, 5157.020166168416, 5174.560162386088, 5183.896322073462, 5195.74021298926, 4954.77703503336, 5054.671446355975, 5206.661566998133, 5215.400228973716, 5244.685318880879, 5090.592752579711, 5106.7957281709805, 5125.410577783454, 5130.897382052263, 5132.948670513247], "value": 3990.0162133882795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.2708439463406, 667.7395815631904, 735.98434160858, 764.6291548598929, 787.2953706432746, 11364.318140911551, 12296.5696200633, 12341.629751107459, 12397.93801030996, 12413.441395137217, 11933.0, 12289.0, 12364.876351236508, 12366.690832729186, 12384.0, 632.5414074795759, 781.4100354232546, 793.468376187954, 807.0355924670022, 807.588130053671, 811.9553424561676, 813.1583810755869, 815.1685281013363, 815.9836803263931, 816.1675091406762, 856.9357298202659, 857.1728282207699, 858.047567200407, 859.0, 859.2481578618708, 848.8090179709516, 850.1073872433919, 850.3239924260197, 850.7873031742096, 852.1521086518923, 618.6071844378807, 619.2785405003166, 620.1349117980392, 623.3361470034399, 624.4348864277836, 11732.296062236293, 11750.471228794724, 11765.764684706259, 11845.23006004607, 11850.288982661068, 12662.683432914251, 12674.302913339763, 12679.746405071846, 12886.80669789954, 13181.143225690395, 9931.304808663397, 10052.296339256254, 10126.696199114038, 10256.846147307797, 10275.92102829207, 3319.9834000830083, 3339.532465454838, 3368.292658541709, 3412.368711788327, 3437.0, 47325.29012064822, 47570.0, 47898.0, 48085.0, 48593.27110093351, 8940.776480588038, 8998.415103018282, 9008.59461324242, 9743.0, 9805.068518490732, 15718.528444146694, 15999.520014399586, 16078.678426431406, 16119.597010074607, 16139.435119770986, 6097.908531372033, 6141.600795948339, 6173.722182501798, 6423.068655044993, 6471.0, 3636.8363423646, 3805.296020236265, 3859.9807000964815, 3877.728559000899, 3916.3146449371247, 2722.5507791214623, 2801.705820888818, 2802.8178168418985, 2803.9299017524727, 2808.9157325280275, 511.6853135321825, 522.2505704314322, 523.2883278740909, 531.4048265942092, 536.1502019299376, 474.6416455576018, 477.33888564337946, 489.36138339466623, 492.0184232456273, 516.4241870314647, 6888.345607167311, 6942.895856562054, 7109.822254443577, 7309.488335816548, 7329.413646908234, 455.3829560944938, 478.0439121756487, 501.79928028788777, 523.3641126031889, 528.1444060621817, 3248.8375581220844, 3248.8700451982127, 3262.8531716072357, 3303.6035675719068, 3310.371029504435, 47202.76398617985, 51110.0, 52158.739206303726, 52302.738486307324, 55916.72041639766, 47953.0, 48085.0, 48836.755816221405, 49498.0, 50090.0, 44018.559814402084, 45692.086158276645, 46048.309275360894, 46686.0, 47056.2941555877, 7815.804604884696, 7861.921380786119, 7875.84248315042, 7932.84134317322, 7976.521408715495, 29774.851125744233, 29820.0, 29821.0, 30365.392692146474, 30701.692983069883, 36174.0, 40175.59824401836, 40641.59358406378, 40674.1865162701, 40807.1838563233, 10764.0, 10816.513256903616, 10820.729481763019, 10878.347299162075, 10894.400807955639, 11459.255148415326, 11986.820197697216, 12179.08656850722, 12283.324417157142, 12350.197237179555, 10717.517711702836, 11298.265612735146, 11315.377654229096, 11694.70763230926, 11702.180847340604, 9821.165200958, 10161.542730576994, 10297.639582614573, 10306.0, 10459.0, 10444.0, 10828.133749300194, 11046.502907369348, 11248.550057997589, 11266.324020558794, 9430.858537122085, 9537.618495260112, 9764.415526138828, 10047.296689231684, 10124.84812727795, 8366.66533338684, 8906.109389061043, 9116.954415227881, 9168.954155229181, 9203.907960920305], "value": 5825.682504089599, "unit": "score"}], "name": "dromaeo_css", "value": 6164.142344434712, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 109.0, 115.0, 113.0, 113.0, 125.0, 115.0, 114.0, 115.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 135.0, 157.0, 185.0, 138.0, 165.0, 156.0, 144.0, 196.0, 134.0], "value": 157.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 165.0, 176.0, 163.0, 163.0, 166.0, 163.0, 174.0, 162.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 177.0, 75.0, 74.0, 77.0, 75.0, 159.0, 74.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 148.0, 94.0, 94.0, 94.0, 150.0, 94.0, 93.0, 149.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 148.0, 149.0, 148.0, 148.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 63.0, 65.0, 65.0, 67.0, 81.0, 63.0, 64.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 66.0, 64.0, 66.0, 65.0, 71.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 88.0, 78.0, 81.0, 82.0, 82.0, 83.0, 80.0, 81.0, 81.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 139.0, 134.0, 141.0, 134.0, 139.0, 141.0, 149.0, 172.0, 142.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 220.0, 227.0, 217.0, 218.0, 214.0, 214.0, 217.0, 218.0, 212.0], "value": 217.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 77.0, 76.0, 73.0, 79.0, 76.0, 75.0, 80.0], "value": 76.4, "unit": "score"}], "name": "kraken", "value": 1653.3000000000002, "alertThreshold": 2.0}]} 04:47:16 INFO - Return code: 0 04:47:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:47:16 ERROR - # TBPL SUCCESS # 04:47:16 INFO - Running post-action listener: _resource_record_post_action 04:47:16 INFO - Running post-run listener: _resource_record_post_run 04:47:17 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 530894848; Read time: 40; Write time: 572168 04:47:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234758144; Read time: 0; Write time: 335604 04:47:17 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296136704; Read time: 40; Write time: 236564 04:47:17 INFO - Running post-run listener: _upload_blobber_files 04:47:17 INFO - Blob upload gear active. 04:47:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:17 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:47:17 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:47:17 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:47:18 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:47:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:47:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:18 INFO - (blobuploader) - INFO - Done attempting. 04:47:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:47:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:47:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:19 INFO - (blobuploader) - INFO - Done attempting. 04:47:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:47:19 INFO - Return code: 0 04:47:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:47:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:47:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/873762deccc1592c7b9075e544dc70058aa94aa8e2052fb435b5c4a5a0452802b0af94a716dfdf9c8159d25ecceb6e01ad4aff0a578b327367848e4770a750c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/342e430207f03b69cf3742cb2b522644cde4edfae01c22f2dff2206b9d8cfed88c4f167f39a9f18574471290696b8f0f87b2aba0a591681b6160300abf00ff67"} 04:47:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:47:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:47:19 INFO - Contents: 04:47:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/873762deccc1592c7b9075e544dc70058aa94aa8e2052fb435b5c4a5a0452802b0af94a716dfdf9c8159d25ecceb6e01ad4aff0a578b327367848e4770a750c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/342e430207f03b69cf3742cb2b522644cde4edfae01c22f2dff2206b9d8cfed88c4f167f39a9f18574471290696b8f0f87b2aba0a591681b6160300abf00ff67"} 04:47:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:47:19 INFO - Copying logs to upload dir... 04:47:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:47:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.987744 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-27 04:47:19.545637) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:47:19.549900) ========= 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=cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/873762deccc1592c7b9075e544dc70058aa94aa8e2052fb435b5c4a5a0452802b0af94a716dfdf9c8159d25ecceb6e01ad4aff0a578b327367848e4770a750c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/342e430207f03b69cf3742cb2b522644cde4edfae01c22f2dff2206b9d8cfed88c4f167f39a9f18574471290696b8f0f87b2aba0a591681b6160300abf00ff67"} build_url:https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/873762deccc1592c7b9075e544dc70058aa94aa8e2052fb435b5c4a5a0452802b0af94a716dfdf9c8159d25ecceb6e01ad4aff0a578b327367848e4770a750c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/342e430207f03b69cf3742cb2b522644cde4edfae01c22f2dff2206b9d8cfed88c4f167f39a9f18574471290696b8f0f87b2aba0a591681b6160300abf00ff67"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:47:19.580870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:47:19.581416) ========= 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=cbe409c6de289db6ac707de3000001d4-1461756326.502384-1068881724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004764 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:47:19.667058) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:47:19.667382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:47:19.667689) ========= ========= Total master_lag: 0.18 =========