builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1461934653.8 results: success (0) buildid: 20160429030215 builduid: 29582e4dd47643738e0a948071b178d8 revision: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:33.803446) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:33.803909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:33.804220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:33.822583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:33.823205) ========= 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=32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 05:57:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.9M=0s 2016-04-29 05:57:34 (33.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070740 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:33.907236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:33.907556) ========= 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=32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014976 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:33.956873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:33.957236) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 --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 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 --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=32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 05:57:34,166 truncating revision to first 12 chars 2016-04-29 05:57:34,166 Setting DEBUG logging. 2016-04-29 05:57:34,166 attempt 1/10 2016-04-29 05:57:34,166 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c3fd523d75b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 05:57:34,413 unpacking tar archive at: mozilla-central-8c3fd523d75b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547718 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:34.518379) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:34.518681) ========= script_repo_revision: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:34.519074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:34.519337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 05:57:34.529487) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-29 05:57:34.529788) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:57:34 INFO - MultiFileLogger online at 20160429 05:57:34 in /builds/slave/test 05:57:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:57:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:34 INFO - {'append_to_log': False, 05:57:34 INFO - 'base_work_dir': '/builds/slave/test', 05:57:34 INFO - 'blob_upload_branch': 'Firefox', 05:57:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:34 INFO - 'branch': 'Firefox', 05:57:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:34 INFO - 'config_files': ('talos/linux_config.py',), 05:57:34 INFO - 'default_actions': ('clobber', 05:57:34 INFO - 'read-buildbot-config', 05:57:34 INFO - 'download-and-extract', 05:57:34 INFO - 'populate-webroot', 05:57:34 INFO - 'create-virtualenv', 05:57:34 INFO - 'install', 05:57:34 INFO - 'run-tests'), 05:57:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:34 INFO - 'download_minidump_stackwalk': True, 05:57:34 INFO - 'download_symbols': 'ondemand', 05:57:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:34 INFO - 'installer_path': 'installer.exe', 05:57:34 INFO - 'log_level': 'info', 05:57:34 INFO - 'log_name': 'talos', 05:57:34 INFO - 'log_to_console': True, 05:57:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:57:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:57:34 INFO - 'opt_config_files': (), 05:57:34 INFO - 'pip_index': False, 05:57:34 INFO - 'sps_profile': False, 05:57:34 INFO - 'sps_profile_interval': 0, 05:57:34 INFO - 'suite': 'dromaeojs-e10s', 05:57:34 INFO - 'system_bits': '32', 05:57:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:34 INFO - 'title': 'talos-linux64-ix-008', 05:57:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:34 INFO - 'use_talos_json': True, 05:57:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:34 INFO - 'work_dir': 'build'} 05:57:34 INFO - ##### 05:57:34 INFO - ##### Running clobber step. 05:57:34 INFO - ##### 05:57:34 INFO - Running pre-action listener: _resource_record_pre_action 05:57:34 INFO - Running main action method: clobber 05:57:34 INFO - rmtree: /builds/slave/test/build 05:57:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:35 INFO - Running post-action listener: _resource_record_post_action 05:57:35 INFO - ##### 05:57:35 INFO - ##### Running read-buildbot-config step. 05:57:35 INFO - ##### 05:57:35 INFO - Running pre-action listener: _resource_record_pre_action 05:57:35 INFO - Running main action method: read_buildbot_config 05:57:35 INFO - Using buildbot properties: 05:57:35 INFO - { 05:57:35 INFO - "project": "", 05:57:35 INFO - "product": "firefox", 05:57:35 INFO - "script_repo_revision": "production", 05:57:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:57:35 INFO - "repository": "", 05:57:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:57:35 INFO - "buildid": "20160429030215", 05:57:35 INFO - "stage_platform": "linux64-pgo", 05:57:35 INFO - "basedir": "/builds/slave/test", 05:57:35 INFO - "nightly_build": "True", 05:57:35 INFO - "buildnumber": 10, 05:57:35 INFO - "slavename": "talos-linux64-ix-008", 05:57:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:57:35 INFO - "platform": "ubuntu64_hw", 05:57:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:57:35 INFO - "branch": "mozilla-central", 05:57:35 INFO - "repo_path": "mozilla-central", 05:57:35 INFO - "revision": "8c3fd523d75bd30f691ca2d6cfdad18d576392a1", 05:57:35 INFO - "pgo_build": "True", 05:57:35 INFO - "builduid": "29582e4dd47643738e0a948071b178d8", 05:57:35 INFO - "slavebuilddir": "test" 05:57:35 INFO - } 05:57:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:57:35 INFO - Running post-action listener: _resource_record_post_action 05:57:35 INFO - ##### 05:57:35 INFO - ##### Running download-and-extract step. 05:57:35 INFO - ##### 05:57:35 INFO - Running pre-action listener: _resource_record_pre_action 05:57:35 INFO - Running main action method: download_and_extract 05:57:35 INFO - mkdir: /builds/slave/test/build/tests 05:57:35 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')]} 05:57:35 INFO - https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/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 05:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/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 05:57:36 INFO - Downloaded 1361 bytes. 05:57:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:57:36 INFO - Using the following test package requirements: 05:57:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:57:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:57:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:57:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:36 INFO - u'jsshell-linux-x86_64.zip'], 05:57:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:57:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:57:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:57:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:57:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:57:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:57:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:36 INFO - https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:57:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/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 05:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/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 05:57:38 INFO - Downloaded 23873520 bytes. 05:57:38 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'] 05:57:38 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 05:57:39 INFO - Return code: 0 05:57:39 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 05:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:39 INFO - https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:57:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/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 05:57:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/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 05:57:41 INFO - Downloaded 23873520 bytes. 05:57:41 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'] 05:57:41 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 05:57:42 INFO - Return code: 0 05:57: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')]} 05:57:42 INFO - https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:57:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:57:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:57:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/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 05:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/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 05:57:44 INFO - Downloaded 10840145 bytes. 05:57:44 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'] 05:57:44 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 05:57:44 INFO - Return code: 0 05:57:44 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')]} 05:57:44 INFO - https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:57:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:57:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:57:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/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 05:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aTvdw-XeQL-m4OahLzUkGg/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 05:57:46 INFO - Downloaded 58392596 bytes. 05:57:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:57:46 INFO - mkdir: /builds/slave/test/properties 05:57:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:57:46 INFO - Writing to file /builds/slave/test/properties/build_url 05:57:46 INFO - Contents: 05:57:46 INFO - build_url:https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:57:47 INFO - Running post-action listener: _resource_record_post_action 05:57:47 INFO - Running post-action listener: set_extra_try_arguments 05:57:47 INFO - ##### 05:57:47 INFO - ##### Running populate-webroot step. 05:57:47 INFO - ##### 05:57:47 INFO - Running pre-action listener: _resource_record_pre_action 05:57:47 INFO - Running main action method: populate_webroot 05:57:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:57:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:57:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:57:47 INFO - '--tppagecycles', 05:57:47 INFO - '7'], 05:57:47 INFO - 'tests': ['tsvgm']}}, 05:57:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:57:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:57:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:57:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:57:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:57:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:57:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:47 INFO - 'talos_options': ['--disable-e10s'], 05:57:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:47 INFO - 'talos_options': ['--disable-e10s'], 05:57:47 INFO - 'tests': ['damp', 'tps']}, 05:57:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:47 INFO - 'tests': ['damp', 'tps']}, 05:57:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:57:47 INFO - 'tests': ['dromaeo_dom']}, 05:57:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:57:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:57:47 INFO - 'tests': ['a11yr', 05:57:47 INFO - 'ts_paint', 05:57:47 INFO - 'tpaint', 05:57:47 INFO - 'sessionrestore', 05:57:47 INFO - 'sessionrestore_no_auto_restore', 05:57:47 INFO - 'tabpaint']}, 05:57:47 INFO - 'other-e10s': {'tests': ['a11yr', 05:57:47 INFO - 'ts_paint', 05:57:47 INFO - 'tpaint', 05:57:47 INFO - 'sessionrestore', 05:57:47 INFO - 'sessionrestore_no_auto_restore', 05:57:47 INFO - 'tabpaint']}, 05:57:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:57:47 INFO - 'ts_paint', 05:57:47 INFO - 'tpaint', 05:57:47 INFO - 'sessionrestore', 05:57:47 INFO - 'sessionrestore_no_auto_restore', 05:57:47 INFO - 'tabpaint']}, 05:57:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:57:47 INFO - 'ts_paint', 05:57:47 INFO - 'tpaint', 05:57:47 INFO - 'sessionrestore', 05:57:47 INFO - 'sessionrestore_no_auto_restore', 05:57:47 INFO - 'tabpaint']}, 05:57:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:57:47 INFO - 'tests': ['a11yr', 05:57:47 INFO - 'ts_paint', 05:57:47 INFO - 'tpaint', 05:57:47 INFO - 'sessionrestore', 05:57:47 INFO - 'sessionrestore_no_auto_restore', 05:57:47 INFO - 'tabpaint']}, 05:57:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:57:47 INFO - 'tests': ['a11yr', 05:57:47 INFO - 'ts_paint', 05:57:47 INFO - 'tpaint', 05:57:47 INFO - 'sessionrestore', 05:57:47 INFO - 'sessionrestore_no_auto_restore', 05:57:47 INFO - 'tabpaint']}, 05:57:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:57:47 INFO - 'tests': ['tsvgx', 05:57:47 INFO - 'tsvgr_opacity', 05:57:47 INFO - 'tart', 05:57:47 INFO - 'tscrollx', 05:57:47 INFO - 'cart']}, 05:57:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:57:47 INFO - 'tsvgr_opacity', 05:57:47 INFO - 'tart', 05:57:47 INFO - 'tscrollx', 05:57:47 INFO - 'cart']}, 05:57:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:47 INFO - 'talos_options': ['--disable-e10s'], 05:57:47 INFO - 'tests': ['tp5o']}, 05:57:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:47 INFO - 'tests': ['tp5o']}, 05:57:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:47 INFO - 'talos_options': ['--disable-e10s', 05:57:47 INFO - '--xperf_path', 05:57:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:47 INFO - 'tests': ['tp5n']}, 05:57:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:47 INFO - 'talos_options': ['--xperf_path', 05:57:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:47 INFO - 'tests': ['tp5n']}}, 05:57:47 INFO - 'talos.zip': {'path': '', 05:57:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:57:47 INFO - Running post-action listener: _resource_record_post_action 05:57:47 INFO - ##### 05:57:47 INFO - ##### Running create-virtualenv step. 05:57:47 INFO - ##### 05:57:47 INFO - Running pre-action listener: _resource_record_pre_action 05:57:47 INFO - Running main action method: create_virtualenv 05:57:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:57:47 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 05:57:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:57:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:57:47 INFO - Using real prefix '/usr' 05:57:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:57:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:57:50 INFO - Installing pip.................done. 05:57:50 INFO - Return code: 0 05:57:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:50 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 0x7fbcc4989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6410>, '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 0x26f7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f77a0>, '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': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', '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 05:57:50 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 05:57:50 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 05:57:50 INFO - Using env: {'DISPLAY': ':0', 05:57:50 INFO - 'HOME': '/home/cltbld', 05:57:50 INFO - 'LANG': 'en_US.UTF-8', 05:57:50 INFO - 'LANGUAGE': 'en_US:en', 05:57:50 INFO - 'LOGNAME': 'cltbld', 05:57:50 INFO - 'MAIL': '/var/mail/cltbld', 05:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:50 INFO - 'MOZ_NO_REMOTE': '1', 05:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:50 INFO - 'NO_EM_RESTART': '1', 05:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:50 INFO - 'PWD': '/builds/slave/test', 05:57:50 INFO - 'SHELL': '/bin/bash', 05:57:50 INFO - 'SHLVL': '1', 05:57:50 INFO - 'TERM': 'linux', 05:57:50 INFO - 'TMOUT': '86400', 05:57:50 INFO - 'USER': 'cltbld', 05:57:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', 05:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:50 INFO - '_': '/tools/buildbot/bin/python'} 05:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:50 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 05:57:50 INFO - Cleaning up... 05:57:50 INFO - Return code: 0 05:57:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:50 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 0x7fbcc4989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6410>, '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 0x26f7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f77a0>, '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': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', '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 05:57:50 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 05:57:50 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 05:57:50 INFO - Using env: {'DISPLAY': ':0', 05:57:50 INFO - 'HOME': '/home/cltbld', 05:57:50 INFO - 'LANG': 'en_US.UTF-8', 05:57:50 INFO - 'LANGUAGE': 'en_US:en', 05:57:50 INFO - 'LOGNAME': 'cltbld', 05:57:50 INFO - 'MAIL': '/var/mail/cltbld', 05:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:50 INFO - 'MOZ_NO_REMOTE': '1', 05:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:50 INFO - 'NO_EM_RESTART': '1', 05:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:50 INFO - 'PWD': '/builds/slave/test', 05:57:50 INFO - 'SHELL': '/bin/bash', 05:57:50 INFO - 'SHLVL': '1', 05:57:50 INFO - 'TERM': 'linux', 05:57:50 INFO - 'TMOUT': '86400', 05:57:50 INFO - 'USER': 'cltbld', 05:57:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', 05:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:50 INFO - '_': '/tools/buildbot/bin/python'} 05:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:50 INFO - Downloading/unpacking psutil>=0.7.1 05:57:50 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 05:57:50 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 05:57:50 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 05:57:50 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 05:57:50 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 05:57:50 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 05:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:57:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:52 INFO - Installing collected packages: psutil 05:57:52 INFO - Running setup.py install for psutil 05:57:52 INFO - building 'psutil._psutil_linux' extension 05:57:52 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 05:57:52 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 05:57:52 INFO - building 'psutil._psutil_posix' extension 05:57:52 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 05:57:52 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 05:57:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:53 INFO - Successfully installed psutil 05:57:53 INFO - Cleaning up... 05:57:53 INFO - Return code: 0 05:57:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:57:53 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')]} 05:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:53 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')]} 05:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:53 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 0x7fbcc4989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6410>, '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 0x26f7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f77a0>, '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': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', '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 05:57:53 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 05:57:53 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 05:57:53 INFO - Using env: {'DISPLAY': ':0', 05:57:53 INFO - 'HOME': '/home/cltbld', 05:57:53 INFO - 'LANG': 'en_US.UTF-8', 05:57:53 INFO - 'LANGUAGE': 'en_US:en', 05:57:53 INFO - 'LOGNAME': 'cltbld', 05:57:53 INFO - 'MAIL': '/var/mail/cltbld', 05:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:53 INFO - 'MOZ_NO_REMOTE': '1', 05:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:53 INFO - 'NO_EM_RESTART': '1', 05:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:53 INFO - 'PWD': '/builds/slave/test', 05:57:53 INFO - 'SHELL': '/bin/bash', 05:57:53 INFO - 'SHLVL': '1', 05:57:53 INFO - 'TERM': 'linux', 05:57:53 INFO - 'TMOUT': '86400', 05:57:53 INFO - 'USER': 'cltbld', 05:57:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', 05:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:53 INFO - '_': '/tools/buildbot/bin/python'} 05:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:57:56 INFO - Installing collected packages: mozsystemmonitor 05:57:56 INFO - Running setup.py install for mozsystemmonitor 05:57:56 INFO - Successfully installed mozsystemmonitor 05:57:56 INFO - Cleaning up... 05:57:56 INFO - Return code: 0 05:57:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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', '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 0x7fbcc4989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6410>, '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 0x26f7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f77a0>, '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': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', '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 05:57: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:57: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 blobuploader==1.2.4 05:57:56 INFO - Using env: {'DISPLAY': ':0', 05:57:56 INFO - 'HOME': '/home/cltbld', 05:57:56 INFO - 'LANG': 'en_US.UTF-8', 05:57:56 INFO - 'LANGUAGE': 'en_US:en', 05:57:56 INFO - 'LOGNAME': 'cltbld', 05:57:56 INFO - 'MAIL': '/var/mail/cltbld', 05:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:56 INFO - 'MOZ_NO_REMOTE': '1', 05:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:56 INFO - 'NO_EM_RESTART': '1', 05:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:56 INFO - 'PWD': '/builds/slave/test', 05:57:56 INFO - 'SHELL': '/bin/bash', 05:57:56 INFO - 'SHLVL': '1', 05:57:56 INFO - 'TERM': 'linux', 05:57:56 INFO - 'TMOUT': '86400', 05:57:56 INFO - 'USER': 'cltbld', 05:57:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', 05:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:56 INFO - '_': '/tools/buildbot/bin/python'} 05:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:57:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:57:58 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 05:57:58 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 05:57:58 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 05:57:58 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 05:57:58 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 05:57:58 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 05:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:57:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:59 INFO - Downloading docopt-0.6.1.tar.gz 05:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:57:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:57:59 INFO - Running setup.py install for blobuploader 05:57:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:57:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:57:59 INFO - Running setup.py install for requests 05:57:59 INFO - Running setup.py install for docopt 05:57:59 INFO - Successfully installed blobuploader requests docopt 05:57:59 INFO - Cleaning up... 05:57:59 INFO - Return code: 0 05:57:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:59 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 0x7fbcc4989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6410>, '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 0x26f7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f77a0>, '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': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', '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 05:57:59 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 05:57:59 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 05:57:59 INFO - Using env: {'DISPLAY': ':0', 05:57:59 INFO - 'HOME': '/home/cltbld', 05:57:59 INFO - 'LANG': 'en_US.UTF-8', 05:57:59 INFO - 'LANGUAGE': 'en_US:en', 05:57:59 INFO - 'LOGNAME': 'cltbld', 05:57:59 INFO - 'MAIL': '/var/mail/cltbld', 05:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:59 INFO - 'MOZ_NO_REMOTE': '1', 05:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:59 INFO - 'NO_EM_RESTART': '1', 05:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:59 INFO - 'PWD': '/builds/slave/test', 05:57:59 INFO - 'SHELL': '/bin/bash', 05:57:59 INFO - 'SHLVL': '1', 05:57:59 INFO - 'TERM': 'linux', 05:57:59 INFO - 'TMOUT': '86400', 05:57:59 INFO - 'USER': 'cltbld', 05:57:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', 05:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:59 INFO - '_': '/tools/buildbot/bin/python'} 05:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:00 INFO - Running setup.py (path:/tmp/pip-TqOu9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:00 INFO - Running setup.py (path:/tmp/pip-kbl8Ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:00 INFO - Running setup.py (path:/tmp/pip-RMTqU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:00 INFO - Running setup.py (path:/tmp/pip-W4XLsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:00 INFO - Running setup.py (path:/tmp/pip-tpbewc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:00 INFO - Running setup.py (path:/tmp/pip-I2PzxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:00 INFO - Running setup.py (path:/tmp/pip-AsywIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:00 INFO - Running setup.py (path:/tmp/pip-UHzbxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:00 INFO - Running setup.py (path:/tmp/pip-FqdOtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:00 INFO - Running setup.py (path:/tmp/pip-1Guqjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:00 INFO - Running setup.py (path:/tmp/pip-exkzDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:00 INFO - Running setup.py (path:/tmp/pip-o3qwXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:00 INFO - Running setup.py (path:/tmp/pip-NGzdQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:01 INFO - Running setup.py (path:/tmp/pip-kGQe66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:01 INFO - Running setup.py (path:/tmp/pip-LahUuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:01 INFO - Running setup.py (path:/tmp/pip-gceXo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:01 INFO - Running setup.py (path:/tmp/pip-Mt1lmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:01 INFO - Running setup.py install for manifestparser 05:58:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:01 INFO - Running setup.py install for mozcrash 05:58:01 INFO - Running setup.py install for mozdebug 05:58:01 INFO - Running setup.py install for mozdevice 05:58:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:01 INFO - Running setup.py install for mozfile 05:58:01 INFO - Running setup.py install for mozhttpd 05:58:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:01 INFO - Running setup.py install for mozinfo 05:58:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:02 INFO - Running setup.py install for mozInstall 05:58:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:02 INFO - Running setup.py install for mozleak 05:58:02 INFO - Running setup.py install for mozlog 05:58:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:02 INFO - Running setup.py install for moznetwork 05:58:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:02 INFO - Running setup.py install for mozprocess 05:58:02 INFO - Running setup.py install for mozprofile 05:58:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:02 INFO - Running setup.py install for mozrunner 05:58:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:02 INFO - Running setup.py install for mozscreenshot 05:58:02 INFO - Running setup.py install for moztest 05:58:03 INFO - Running setup.py install for mozversion 05:58:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:03 INFO - Cleaning up... 05:58:03 INFO - Return code: 0 05:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:03 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')]} 05:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:03 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')]} 05:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:03 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 0x7fbcc4989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6410>, '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 0x26f7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f77a0>, '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': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', '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 05:58:03 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 05:58:03 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 05:58:03 INFO - Using env: {'DISPLAY': ':0', 05:58:03 INFO - 'HOME': '/home/cltbld', 05:58:03 INFO - 'LANG': 'en_US.UTF-8', 05:58:03 INFO - 'LANGUAGE': 'en_US:en', 05:58:03 INFO - 'LOGNAME': 'cltbld', 05:58:03 INFO - 'MAIL': '/var/mail/cltbld', 05:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:03 INFO - 'MOZ_NO_REMOTE': '1', 05:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:03 INFO - 'NO_EM_RESTART': '1', 05:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:03 INFO - 'PWD': '/builds/slave/test', 05:58:03 INFO - 'SHELL': '/bin/bash', 05:58:03 INFO - 'SHLVL': '1', 05:58:03 INFO - 'TERM': 'linux', 05:58:03 INFO - 'TMOUT': '86400', 05:58:03 INFO - 'USER': 'cltbld', 05:58:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', 05:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:03 INFO - '_': '/tools/buildbot/bin/python'} 05:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:03 INFO - Running setup.py (path:/tmp/pip-TfsCjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:03 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)) 05:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:03 INFO - Running setup.py (path:/tmp/pip-QDIadl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:03 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)) 05:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:03 INFO - Running setup.py (path:/tmp/pip-XvhwGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:03 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)) 05:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:03 INFO - Running setup.py (path:/tmp/pip-iCCswH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:03 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)) 05:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:03 INFO - Running setup.py (path:/tmp/pip-cWrk7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:03 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)) 05:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:03 INFO - Running setup.py (path:/tmp/pip-NmUddf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:03 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)) 05:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:03 INFO - Running setup.py (path:/tmp/pip-kgARLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:03 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)) 05:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:03 INFO - Running setup.py (path:/tmp/pip-EBxq_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:03 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)) 05:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:03 INFO - Running setup.py (path:/tmp/pip-c58pdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:03 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)) 05:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:03 INFO - Running setup.py (path:/tmp/pip-D_nvJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:04 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)) 05:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:04 INFO - Running setup.py (path:/tmp/pip-K40Ag7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:04 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)) 05:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:04 INFO - Running setup.py (path:/tmp/pip-AMSetl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:04 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)) 05:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:04 INFO - Running setup.py (path:/tmp/pip-Se1Y0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:04 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)) 05:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:04 INFO - Running setup.py (path:/tmp/pip-VkZ_SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:04 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)) 05:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:04 INFO - Running setup.py (path:/tmp/pip-Iua4vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:04 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)) 05:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:04 INFO - Running setup.py (path:/tmp/pip-fAvoYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:04 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)) 05:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:04 INFO - Running setup.py (path:/tmp/pip-8wuxYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:04 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)) 05:58:04 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)) 05:58:04 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)) 05:58:04 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)) 05:58:04 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)) 05:58:04 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)) 05:58:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:06 INFO - Downloading blessings-1.6.tar.gz 05:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:06 INFO - Installing collected packages: blessings 05:58:06 INFO - Running setup.py install for blessings 05:58:06 INFO - Successfully installed blessings 05:58:06 INFO - Cleaning up... 05:58:06 INFO - Return code: 0 05:58:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:06 INFO - Reading from file tmpfile_stdout 05:58:06 INFO - Current package versions: 05:58:06 INFO - argparse == 1.2.1 05:58:06 INFO - blessings == 1.6 05:58:06 INFO - blobuploader == 1.2.4 05:58:06 INFO - docopt == 0.6.1 05:58:06 INFO - manifestparser == 1.1 05:58:06 INFO - mozInstall == 1.12 05:58:06 INFO - mozcrash == 0.17 05:58:06 INFO - mozdebug == 0.1 05:58:06 INFO - mozdevice == 0.48 05:58:06 INFO - mozfile == 1.2 05:58:06 INFO - mozhttpd == 0.7 05:58:06 INFO - mozinfo == 0.9 05:58:06 INFO - mozleak == 0.1 05:58:06 INFO - mozlog == 3.1 05:58:06 INFO - moznetwork == 0.27 05:58:06 INFO - mozprocess == 0.22 05:58:06 INFO - mozprofile == 0.28 05:58:06 INFO - mozrunner == 6.11 05:58:06 INFO - mozscreenshot == 0.1 05:58:06 INFO - mozsystemmonitor == 0.0 05:58:06 INFO - moztest == 0.7 05:58:06 INFO - mozversion == 1.4 05:58:06 INFO - psutil == 3.1.1 05:58:06 INFO - requests == 1.2.3 05:58:06 INFO - wsgiref == 0.1.2 05:58:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:06 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')]} 05:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:06 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')]} 05:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:06 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 0x7fbcc4989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6410>, '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 0x26f7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f77a0>, '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': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', '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 05:58:06 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 05:58:06 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 05:58:06 INFO - Using env: {'DISPLAY': ':0', 05:58:06 INFO - 'HOME': '/home/cltbld', 05:58:06 INFO - 'LANG': 'en_US.UTF-8', 05:58:06 INFO - 'LANGUAGE': 'en_US:en', 05:58:06 INFO - 'LOGNAME': 'cltbld', 05:58:06 INFO - 'MAIL': '/var/mail/cltbld', 05:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:06 INFO - 'MOZ_NO_REMOTE': '1', 05:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:06 INFO - 'NO_EM_RESTART': '1', 05:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:06 INFO - 'PWD': '/builds/slave/test', 05:58:06 INFO - 'SHELL': '/bin/bash', 05:58:06 INFO - 'SHLVL': '1', 05:58:06 INFO - 'TERM': 'linux', 05:58:06 INFO - 'TMOUT': '86400', 05:58:06 INFO - 'USER': 'cltbld', 05:58:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', 05:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:06 INFO - '_': '/tools/buildbot/bin/python'} 05:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:07 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)) 05:58:07 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)) 05:58:07 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)) 05:58:07 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)) 05:58:07 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)) 05:58:07 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)) 05:58:07 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)) 05:58:07 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)) 05:58:07 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)) 05:58:07 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)) 05:58:07 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)) 05:58:07 INFO - Cleaning up... 05:58:07 INFO - Return code: 0 05:58:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc4989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6410>, '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 0x26f7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f77a0>, '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': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', '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 05:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:58:07 INFO - Using env: {'DISPLAY': ':0', 05:58:07 INFO - 'HOME': '/home/cltbld', 05:58:07 INFO - 'LANG': 'en_US.UTF-8', 05:58:07 INFO - 'LANGUAGE': 'en_US:en', 05:58:07 INFO - 'LOGNAME': 'cltbld', 05:58:07 INFO - 'MAIL': '/var/mail/cltbld', 05:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:07 INFO - 'MOZ_NO_REMOTE': '1', 05:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:07 INFO - 'NO_EM_RESTART': '1', 05:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:07 INFO - 'PWD': '/builds/slave/test', 05:58:07 INFO - 'SHELL': '/bin/bash', 05:58:07 INFO - 'SHLVL': '1', 05:58:07 INFO - 'TERM': 'linux', 05:58:07 INFO - 'TMOUT': '86400', 05:58:07 INFO - 'USER': 'cltbld', 05:58:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', 05:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:07 INFO - '_': '/tools/buildbot/bin/python'} 05:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:07 INFO - Downloading/unpacking jsonschema 05:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:09 INFO - Downloading/unpacking functools32 (from jsonschema) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:09 INFO - warning: no files found matching '*.txt' 05:58:09 INFO - no previously-included directories found matching 'build' 05:58:09 INFO - no previously-included directories found matching 'dist' 05:58:09 INFO - no previously-included directories found matching '.git*' 05:58:09 INFO - Installing collected packages: jsonschema, functools32 05:58:09 INFO - Running setup.py install for functools32 05:58:09 INFO - warning: no files found matching '*.txt' 05:58:09 INFO - no previously-included directories found matching 'build' 05:58:09 INFO - no previously-included directories found matching 'dist' 05:58:09 INFO - no previously-included directories found matching '.git*' 05:58:09 INFO - Successfully installed jsonschema functools32 05:58:09 INFO - Cleaning up... 05:58:09 INFO - Return code: 0 05:58:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc4989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6410>, '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 0x26f7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f77a0>, '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': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', '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 05:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:58:09 INFO - Using env: {'DISPLAY': ':0', 05:58:09 INFO - 'HOME': '/home/cltbld', 05:58:09 INFO - 'LANG': 'en_US.UTF-8', 05:58:09 INFO - 'LANGUAGE': 'en_US:en', 05:58:09 INFO - 'LOGNAME': 'cltbld', 05:58:09 INFO - 'MAIL': '/var/mail/cltbld', 05:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:09 INFO - 'MOZ_NO_REMOTE': '1', 05:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:09 INFO - 'NO_EM_RESTART': '1', 05:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:09 INFO - 'PWD': '/builds/slave/test', 05:58:09 INFO - 'SHELL': '/bin/bash', 05:58:09 INFO - 'SHLVL': '1', 05:58:09 INFO - 'TERM': 'linux', 05:58:09 INFO - 'TMOUT': '86400', 05:58:09 INFO - 'USER': 'cltbld', 05:58:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', 05:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:09 INFO - '_': '/tools/buildbot/bin/python'} 05:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:09 INFO - Downloading/unpacking flake8 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:58:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:58:11 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 05:58:11 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 05:58:11 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 05:58:11 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 05:58:11 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 05:58:11 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 05:58:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:58:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:58:11 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 05:58:11 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 05:58:11 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 05:58:11 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 05:58:11 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 05:58:11 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 05:58:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:12 INFO - no previously-included directories found matching 'docs/_build' 05:58:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:58:12 INFO - Running setup.py install for pep8 05:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:12 INFO - no previously-included directories found matching 'docs/_build' 05:58:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:58:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:58:12 INFO - Cleaning up... 05:58:12 INFO - Return code: 0 05:58:12 INFO - Running post-action listener: _resource_record_post_action 05:58:12 INFO - Running post-action listener: _start_resource_monitoring 05:58:12 INFO - Starting resource monitoring. 05:58:12 INFO - ##### 05:58:12 INFO - ##### Running install step. 05:58:12 INFO - ##### 05:58:12 INFO - Running pre-action listener: _resource_record_pre_action 05:58:12 INFO - Running main action method: install 05:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:12 INFO - Reading from file tmpfile_stdout 05:58:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:13 INFO - Reading from file tmpfile_stdout 05:58:13 INFO - Output received: 05:58:13 INFO - Usage: mozinstall [options] installer 05:58:13 INFO - Options: 05:58:13 INFO - -h, --help show this help message and exit 05:58:13 INFO - -d DEST, --destination=DEST 05:58:13 INFO - Directory to install application into. [default: 05:58:13 INFO - "/builds/slave/test"] 05:58:13 INFO - --app=APP Application being installed. [default: firefox] 05:58:13 INFO - mkdir: /builds/slave/test/build/application 05:58:13 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'] 05:58:13 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 05:58:29 INFO - Reading from file tmpfile_stdout 05:58:29 INFO - Output received: 05:58:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:58:29 INFO - Running post-action listener: _resource_record_post_action 05:58:29 INFO - ##### 05:58:29 INFO - ##### Running run-tests step. 05:58:29 INFO - ##### 05:58:29 INFO - Running pre-action listener: _resource_record_pre_action 05:58:29 INFO - Running main action method: run_tests 05:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:29 INFO - Python 2.7.3 05:58:29 INFO - Return code: 0 05:58:29 INFO - grabbing minidump binary from tooltool 05:58:29 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')]} 05:58:29 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 0x26f6410>, '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 0x26f7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:29 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 05:58:29 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 05:58:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:29 INFO - Return code: 0 05:58:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:58:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:58:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:58:30 INFO - Return code: 0 05:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 05:58:30 INFO - Using env: {'DISPLAY': ':0', 05:58:30 INFO - 'HOME': '/home/cltbld', 05:58:30 INFO - 'LANG': 'en_US.UTF-8', 05:58:30 INFO - 'LANGUAGE': 'en_US:en', 05:58:30 INFO - 'LOGNAME': 'cltbld', 05:58:30 INFO - 'MAIL': '/var/mail/cltbld', 05:58:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:30 INFO - 'MOZ_NO_REMOTE': '1', 05:58:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:30 INFO - 'NO_EM_RESTART': '1', 05:58:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:30 INFO - 'PWD': '/builds/slave/test', 05:58:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:30 INFO - 'SHELL': '/bin/bash', 05:58:30 INFO - 'SHLVL': '1', 05:58:30 INFO - 'TERM': 'linux', 05:58:30 INFO - 'TMOUT': '86400', 05:58:30 INFO - 'USER': 'cltbld', 05:58:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732', 05:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:30 INFO - '_': '/tools/buildbot/bin/python'} 05:58:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:58:30 INFO - mozversion application_buildid: 20160429030215 05:58:30 INFO - mozversion application_changeset: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 05:58:30 INFO - mozversion application_display_name: Nightly 05:58:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:30 INFO - mozversion application_name: Firefox 05:58:30 INFO - mozversion application_remotingname: firefox 05:58:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:58:30 INFO - mozversion application_vendor: Mozilla 05:58:30 INFO - mozversion application_version: 49.0a1 05:58:30 INFO - mozversion platform_buildid: 20160429030215 05:58:30 INFO - mozversion platform_changeset: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 05:58:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:58:30 INFO - mozversion platform_version: 49.0a1 05:58:30 INFO - using testdate: 1461934710 05:58:30 INFO - actual date: 1461934710 05:58:30 INFO - starting webserver on 'localhost:58482' 05:58:30 INFO - SUITE-START | Running 2 tests 05:58:30 INFO - TEST-START | dromaeo_css 05:58:30 INFO - operating with platform_type : linux_ 05:58:30 INFO - Initialising browser for dromaeo_css test... 05:58:30 INFO - TEST-INFO | started process 7272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoTZkZ1/profile http://localhost:58482/getInfo.html) 05:58:34 INFO - PROCESS | 7272 | 05:58:34 INFO - PROCESS | 7272 | (process:7338): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:58:35 INFO - PROCESS | 7272 | __metrics Screen width/height:1600/1200 05:58:35 INFO - PROCESS | 7272 | colorDepth:24 05:58:35 INFO - PROCESS | 7272 | Browser inner width/height: 1024/697 05:58:35 INFO - PROCESS | 7272 | __metrics 05:58:35 ERROR - PROCESS | 7272 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:58:36 INFO - TEST-INFO | 7272: exit 0 05:58:36 INFO - Browser initialized. 05:58:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:58:36 INFO - TEST-INFO | started process 7389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoTZkZ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:38 INFO - PROCESS | 7389 | 05:58:38 INFO - PROCESS | 7389 | (process:7450): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:58:48 INFO - PROCESS | 7389 | RSS: Main: 164564992 05:58:48 INFO - PROCESS | 7389 | 05:59:38 INFO - PROCESS | 7389 | 1461934778083 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] 06:01:45 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:58482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58482/tests/dromaeo/cssquery-ext.html) 06:01:46 INFO - PROCESS | 7389 | RSS: Main: 168935424 06:01:46 INFO - PROCESS | 7389 | 06:04:48 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:58482/tests/dromaeo/cssquery-ext.html (next: http://localhost:58482/tests/dromaeo/cssquery-jquery.html) 06:04:49 INFO - PROCESS | 7389 | RSS: Main: 166629376 06:04:49 INFO - PROCESS | 7389 | 06:07:50 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:58482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58482/tests/dromaeo/cssquery-mootools.html) 06:07:51 INFO - PROCESS | 7389 | RSS: Main: 167710720 06:07:51 INFO - PROCESS | 7389 | 06:10:53 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:58482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58482/tests/dromaeo/cssquery-prototype.html) 06:10:53 INFO - PROCESS | 7389 | RSS: Main: 164913152 06:10:53 INFO - PROCESS | 7389 | 06:13:56 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:58482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58482/tests/dromaeo/cssquery-yui.html) 06:13:56 INFO - PROCESS | 7389 | RSS: Main: 165879808 06:13:56 INFO - PROCESS | 7389 | 06:16:58 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:58482/tests/dromaeo/cssquery-yui.html (next: http://localhost:58482/tests/dromaeo/cssquery-dojo.html) 06:16:59 INFO - PROCESS | 7389 | RSS: Main: 168574976 06:16:59 INFO - PROCESS | 7389 | 06:16:59 INFO - PROCESS | 7389 | __start_tp_report 06:16:59 INFO - PROCESS | 7389 | _x_x_mozilla_page_load 06:16:59 INFO - PROCESS | 7389 | _x_x_mozilla_page_load_details 06:16:59 INFO - PROCESS | 7389 | |i|pagename|runs| 06:16:59 INFO - PROCESS | 7389 | |0;dojo.html;3117.392108538835;3193.712565869071;3201.1516948008775;3223.081421794789;3246.9512957305647;5337.252784610153;5352.116900711388;5385.649932754373;5387.057264978628;5435.864103397417;5292.682439053659;5381;5415.918761218575;5473.425290344516;5494.120940649497;4907.435644900837;4929.876753081166;4979.30289759434;5012.706512025013;5026.547610715035;608.6743013277759;4753.548412900769;4857.368542089541;4878.097551952882;4973.030259099477;4859.829905953292;4869.123557759602;4890.046440944017;4895.485973972735;4902.436219834729;4843.564079232886;4864.148773964542;4886.657933944625;4913.091078150518;4943.134951383494;4752.619790416758;4859.125357435661;4890.608751299887;4911.607071434277;4949.133901567211;5277.050130976423;5293.206019097166;5300.09898317287;5316.308879845634;5371.113766228567;5586.16207568868;5774.162746401748;5780.248567686216;5790.913136302959;5802.97098514509;5735.1970724098655;5744.597878148531;5765.106408506646;5809.738561764731;5825.825225243249;5362.222477740745;5371.785128594852;5385.7307134643115;5386.649867758583;5387.164989426606;5673.914891276634;5851.736671849777;5852.473277404969;5861.794837180763;5888.735006924699;5688.54491640676;5694.601377903507;5695.829125126253;5700.828975130753;5747.5114615257335;5760.308762948473;5763.279590051244;5777.8555536111935;5777.88444231113;5791.913121303184;5559.833205003856;5693.117566777156;5726.341470730836;5754.280714910637;5766.942330576724;5667.319921609434;5669.659820410789;5681.744321505542;5699.230603868425;5715.485606295453;4314.115606300701;4337.50118736343;4359.14996575671;4360.127974405068;4398.73607583546;3824.808759562011;3873.8644147455266;3881.844726210976;3922.392029235416;3946.664533514626;5400.135978243462;5425.728713564306;5466.371367292732;5467.835964921059;5469.726513674301;5705.343885453143;5748.798792042258;5770.221020162308;5805.88388232233;5816.82549523515;5363.088274993261;5500.559955203574;5507.118860982224;5559.277293951841;5604.467575580395;4915.877103072452;4925.729084900365;4928.383952005999;4931.9753401232765;5003.074431230234;5973.910391344133;6005.459508644243;6017.037274036134;6018.428249316308;6020.458158765732;5586.636868603609;5653.1802888580105;5704.543636508986;5794.188813566188;5823.242978412779;5808.796692115756;5813.302403711582;5820.097884827858;5823.388544202798;5849.678267695318;5514.641548299348;5549.722513874371;5592.105263157875;5600.439956004367;5615.691136987505;5687.20379146928;5707.086866101404;5729.455701708331;5749.91375129365;5784;5521.4478552144465;5533.861653458695;5547.112462006221;5563.471470210324;5568.610197286151;5429.864253393696;5533.446655334435;5544.085225937675;5576;5603.607747457639;5513.669179849222;5539.916901246565;5550.5282051026115;5572.832815015556;5595.832125036255;5628.521575666115;5634.52106570946;5637.577181711306;5671.149327600728;5672.631278966854;5383.488568585978;5459.727013649381;5522.502974732293;5553.4724201200825;5581.358143813513 06:16:59 INFO - PROCESS | 7389 | |1;ext.html;600.6006006006006;640.9936399852232;653.225927276178;656.2223764838665;668.3583759590792;37275.44086838696;38224.61775382242;38242.8087859561;38398;38520.22959540808;42947.78526107373;43478.78260608693;43668.344974825406;43713.34429983545;43749.12501749971;8688.913110868889;8913.732588022369;8922.330825188104;8937.106289371075;8964.50695211763;8769.7807554811;8875.556222188898;8895.243904268145;8903.287736981027;8919.286457083417;8904.910950890473;8987.281017518615;8987.730368088967;8995.685151019716;9015.14356136166;8830.293576513863;8836.8674469883;8917.821643567126;8937.553122343921;8950.910490895105;8662.350323725746;8714.389992700513;8764;8764.386492945496;8794.648214071494;29951.850240748656;39830.40254396186;39863.60136398657;40086.99782505431;40168.39747403791;3328.484084966834;3473.3400653875683;3649.416093425066;3696.907577310562;4353.28170851809;30517.389652207054;31917.361652767046;33306.83346583252;33535.16162095943;34114.147146321295;4135.710500264982;4327.826886924519;4330.30715085588;4370.912581748347;4477.843275485375;302128;306933;309165;310238;310288;34030;34976;65666;66218.66890665612;66375.02624763794;38343.616563834;38361.616383836365;38551.807240963615;38607.42088868669;38615;14745.77881331781;14933.850661493247;14949;14985.175815330043;15013.69972600542;12496.81254781179;12617;12632.747345053047;12640.988720902305;12697.93651031739;8682.479051256818;8713.172248636369;8737.30101591871;8758.86861697075;8792.516411597295;3471.7916924984584;3505.088676944013;3515.736319776027;3543.7342199335153;3545.1314427965312;1047.272145858621;1094.9069329106956;1123.904468120219;1126.8253420719802;1170.3913964738288;32653.836730816194;32788.508172377435;33021.66978330186;33417.3316533668;33937.15157121092;1085.2999815119363;1129.6102844518628;1151.6545036489188;1205.9336736479577;1274.095392271479;15295;15761.921190393974;16392.180390980404;16415;16841.915790421215;515327;516813;519156;520685;523984;58519.70740146357;59444.70277648671;59513.70243148757;59541.40458595358;59685.403145968856;1400.7688731359415;1451.083322521718;1455.2432734977751;1459.1245252848419;1567.1067491529946;30309;30754.53868191934;30766.538501922936;30965.845170774002;30984.845075774476;49320.260196097806;49583.504164957885;49683;49892;49939;398615;399083;401610;404091;404183;28669.521926207475;29030.27424314409;29774.553381698857;29940.550891736206;30068.24829379283;48273.27590086081;49136.262956054976;49328.753356234425;49373.50626493689;49905;41482.05920437554;41675;41750.956226093374;41837.372439414044;43616.34575481307;41893.371599426646;43031.35452968271;43146;43265.567344326155;44028.33957490576;36403;37571;38454.42318365283;41808.79095604503;43784.90537736582;32492.512612310362;33445.83277083599;35136;35504.82247588746;35733.82133089318;27614.309642259104;28317.433651327272;28350.76283217689;28388.194555007394;28590.142295731162 06:16:59 INFO - PROCESS | 7389 | |2;jquery.html;394.5521832719864;395.2509993562199;396.2550405238152;398.8484375937144;414.0848724319254;14524.636884077903;18197.545061373472;18698.906505467487;18902.24391024359;18929.24283028679;17840.46478605644;18016.279348826065;18276.08619569023;18856.434306970812;18963.905180474114;5060.519250671189;5186.403563590179;5751.511121554652;5914.733836977346;5915.112733090049;5806.477417032466;5810.24466819315;5849.707514624273;5853.853653658672;5855.531557475413;5284.762185701634;5299.60252981026;5318.0161670090965;5325.467453254682;5728.971355143219;5192.480751924796;5219.921701174486;5266.183741520071;5268.262443257928;5292.708901010443;4965.230389289666;5274.156135018378;5279.841604751864;5291.497307755757;5296.814611488579;13048.543300984515;13541.984351173603;13583.932080339633;20485.795142048686;22736.77263227363;2194.8902554872193;2212.712347394828;2346.9061237550477;2428.9392765180837;2441.6215486599604;9234.584443700049;10392.428416437093;10743.247972641919;13735.175889446666;14907.105573665507;1971.8225359717694;1976.594798066393;1997.470670272379;2008.6685696860147;2033.522122301258;78903;79682.20317796805;79884.60057699675;80050;80919.5954020232;10636.680899573024;10715.624953126604;10793.460326983619;10854.960611028924;10941.671749847517;14667.48663796762;14755.262236888113;14855.108693478425;29957.70042299549;31328;9270.887493500688;9335.486548239913;9435.905640943503;9451.149396554343;9506.667266645773;7607.885881711779;7728.884066739003;8012.0786109596975;8049.074356448966;8149.225823546753;8671.176238257356;8913.910860891438;8973.564229723213;8994.550272486349;9072.95463522678;3435.7766745161484;3535.275268569937;3559.7864128152396;3615.367310720666;3736.962630373716;932.5011119051275;1040.4641609571077;1042.921780866438;1083.653230966099;1118.798616249083;18663.346782862536;18859.151338189815;18926.526836828914;19676.114574844167;19696.212151514064;1008.8587597736323;1021.4841505040056;1042.4943902207424;1043.0560342889696;1116.0792346314324;10447.164226861833;10496.947515262527;10745.301555398873;10792.406417646947;11015;434415;437593;456408;478940;479211;84871;86667.56666216755;87560.12439875647;98879;104686;466.9463011753692;484.41869756291885;486.45031114840714;487.5611949245707;489.104937963533;10202.33684810485;10476.68569942903;10742.194335424718;10872.782544349227;11077.72305692332;35908.10229744173;37581.4362784553;37789.43315850209;38653.420198696476;39496;49734.50265497299;53710;54719.452805473025;56070.43929560652;56840.71579642075;8181.140980196994;8381.329493640616;8417.915820841958;8496.830063398822;8586.742397728078;9283.48940808262;11121.555137794398;12380.319082450551;13288.734225315633;13423.597292081253;11847.822282665595;11857.16999810005;11903.642890713292;12020.278783273032;12193.207441516273;11277.661670149908;11662.241954272946;11699;11877.881221187678;12096.818547721616;12041.879581204075;12046.156769026084;12277.201981871507;12330.568430105262;12532.624021279376;8706;8830.955845220733;8911.688090916787;8912.376133670581;9038.864417033881;8567.314614830922;10808.297460665031;11549.364784936573;11579;11607.30356178632 06:16:59 INFO - PROCESS | 7389 | |3;mootools.html;1530.9311081001354;1532.6704758476926;1699.4816580942806;1761.1282415204475;1812.8277813607704;7082.539634923726;7592.8861067084035;7612.847743045136;7940.801479963004;7944.205579442053;7665.4634175607725;7677.65450554725;7701.152873183959;7702.42231832612;7763.534187948727;2129.0525716056363;2165.4911095892453;2167.7398712154563;2169.652855543113;2171.554831259596;2048.5902819436096;2058.619155456238;2071.3682326890294;2078.449210959097;2084.47888027993;2069.9586008279825;2069.9896500517552;2081.739782527184;2085.9269925552608;2090.80137386948;2015.042854644047;2030.4010316956533;2040.9489762755902;2041.1937284772505;2043.039771307483;2036.7352244208157;2050.261905713942;2090.707300977864;2092.3199960013058;2098.3390232076845;7828.765137045841;7871.055473343178;7878.4485086044;7892.960535197287;7897.210278972057;4618.099470603233;4774.40319960005;4794.089123066641;4814.951850481485;4825.324454576362;3062.096681478969;3090.8454577271273;3130.89041883533;3145.905622831319;3148.370325934822;1059.0944742245424;1078.563181911327;1091.9727006824894;1111.111111111108;1121.6915348279206;10323.638672646497;10356.378617282988;10373.11828494579;10380.377177369306;10417.322874013165;4152.958470415258;4167.9583204168175;4242.53332133465;4251.256030194703;4269.31690929456;8962.462252264884;8975.685850995314;8976.955115224382;8985.326100542485;8989.10108989109;4740.1230772307235;4753.786079626425;4775.06886157196;4809.879753006203;4810.687305325213;3854.5952674968726;4343.891402714958;4417.933730994037;4479.260921947842;4509.436320459942;3520.3487354839435;3544.3442963051916;3555.7866528008403;3608.1340478285024;3652.251288485854;1116.8883111688765;1155.2029099921028;1157.8784227655974;1159.287038471334;1159.675290918544;1004.1565085328214;1007.8992100789862;1019.2712210769336;1023.7184774187158;1031.4120951057826;5588.804391846347;5620.353659329147;5662.971685141548;5751.396103409165;5883.235179426647;957;967.2213867836318;981.3817295104182;994.7363948553639;1048.905598496139;4152.37714342851;4180.895477613023;4203.936940945889;4259.914801703949;4272.829086836492;9258.629654813867;9609.90390096104;9688.370255933341;9693.466859322805;9718.028197180367;9555.331126821195;9581.473018984023;9605.615775368908;9662.516874156265;9668.613255469703;7054.294570542905;7323.084614423197;7361.190269070505;7363.337299643058;7397.18630950595;5401.918971215357;5689.374168841507;5778.537716982547;5784.739686714024;5822.359540450462;8618.741437756877;9010.279177665901;9032.232260257952;9097.727068187965;9139.817203655757;8965.462072275684;9040.502772347583;9132.863007054766;9281.350305478552;9285.72142835716;6268.874622507616;6771.322867713189;7041.6831242595235;7050.964745176241;7156.069710937545;7536.321731044013;7556.093268807778;7573.621318933921;7601.695932162652;7613.390928725799;6546.223601121274;6701.396874281338;6720.630365329954;6729.764458243938;6793.898091528532;6535.57518761279;6564.277929427663;6632.071509988509;6638.734450621921;6652.866942661217;6115.663638499926;6233.2208473940755;6254.718537665725;6257.749690012349;6263.6241825490615;4883.658143929891;4901.950980490149;4994.02616489781;5015.724135172601;5115.283860259492;4862.805487780449;4950.183219768698;5101.387833460009;5163.044836705071;5245.423003469539 06:16:59 INFO - PROCESS | 7389 | |4;prototype.html;324.57480700282633;325.8696521391445;331.97842140260883;335.0534739361305;336.48349783082955;5498.285222921019;5558.610897237195;5584.274044374226;5611.164389035398;5627.184058311543;5455.18172274159;5461.481159289871;5500.532454741352;5511.421300763423;5526.834194974147;4064.7154699170997;4098.098418347973;4218.303979843337;4240.62179791569;4277.700560960734;4197.8530751423705;4224.324108142698;4234.894127646818;4238.936415953764;4264.083222107246;4199.2441360555085;4203.159368126372;4218.755467137186;4239.1521695660995;4248.638865696404;4079.5104587449546;4245.702800803945;4254.659627229814;4259.339802330644;4262.6376757975295;3699;3716.9035134635346;3730.515033045687;3731.7574357666663;3739.700823934079;5255.500727430888;5276.419593844674;5290.312259406252;5301.6818990860675;5323.281357016792;4708.085733782955;4808.75956202192;4847.418309802811;4900.534449227318;4910.508949105097;5699.145128230757;5735.569832262555;5753.827385178452;5786.652800831921;5788.5369170466265;4101.569335219819;4113.9794301028605;4116.547179810218;4126.195391898581;4132.421460995463;5653.689047102408;6058.333583305789;6066.272047354301;6081.908771368433;6113.449789518964;4056.6551843093666;4093.795310234536;4103.281925662997;4104.322786740155;4118.382242663624;4098.7130900836655;4110.527289361702;4121.670266378683;4139.606737359946;4143.875683729493;4560.657950653648;4768.833090841804;4773.591790421834;4801.135795556834;4820.831270905502;5782.971085144547;5824.514748739044;5827.883442331215;5841.678707671119;5862.589618726648;1493.46235355272;1498.4905132255085;1506.49532406645;1511.780791785185;1516.1282262698992;913.4930113786779;967.6226271754022;984.6652138273022;991.7173605522391;997.3218211616171;5926.525877929756;5938.406159384027;5943.762249509971;5951.137085122719;5957.434043765836;6239.625622462667;6247.781327653511;6275.843103922439;6365.681715914186;6404.519661025349;5798.362180160179;5834.27071616048;5896.557758168155;5905.409459054146;5940.821775346746;3348.648391918862;3357.2110554019787;3372.730181585467;3382.797032178077;3402.472616744359;6390.370455533902;6468.514861385415;6523.151990241238;6551.443127334134;6577.934220657828;6446.774362897276;6447.6131432114225;6448.548601597843;6451.1936007999;6459.483241340681;6332.208473940757;6497.740090396331;6533.150690410216;6579.374959378852;6592.76925307612;6273.843153921189;6274.749010039547;6302.369763023661;6318.778842740482;6327.936720632735;6179.660118693515;6270.0908368287255;6282.246130464374;6297.338779428094;6309.012661011767;6432.742690292524;6477.935220647733;6505;6520.043986804035;6550.83622909412;4252.787360632018;4268.381084742757;4283.892902677333;4290.141971605629;4294.098239369768;6253.874922501615;6275.403836635513;6323.588966717149;6347.460465860454;6372.840678983062;6075.483583895419;6128.724207410588;6130.172426722335;6185.350538193605;6188.535859810442;5947.672877991752;6133.233345831771;6157.84605384869;6176.227971503562;6200.627962322094;5444.237806707143;5544.251526043932;5691.459311365414;6010.669413182317;6034.909476357946;5820.476157145878;5860.677662728591;5871.794487192928;5886.175935368966;5890.352061273342;5559.833205003856;5721.828345149652;5797.333306669619;5797.710114494174;5818.0981947798155 06:16:59 INFO - PROCESS | 7389 | |5;yui.html;744.121936115384;797.1152021256404;820.7086484298073;823.9217274358941;851.6976473351959;14351.282435878204;14638.194899280536;14677.926610366947;14910.105393676373;14911.254437278147;13566.72866542671;13678.179309241452;13683.24742139182;13695.726085478285;13750.106243094191;836.1346006882877;867.8394497018072;869.6651789061194;870.2646263906988;872.7512658892217;846.5978660136417;853.2789792625252;853.56894768142;856.3235044315015;858.2061593026425;895.8790563273973;896.8520194167954;899.9010108888017;902.0573500691793;902.467544148952;887.5650931043807;891.7948871759467;894.592960203106;896.8565029595266;901.3600343755941;649.04590252329;654.319507711979;655.1188651264042;655.632845606462;658.6904155047168;14619.92690036543;14655;14727.337269822883;14751;14780.743636790885;13632.727345453135;13783.51757688476;14030;14068.718625627533;14095.295235238196;11418.029467495273;11530.365829879353;11547.711307217303;11559.479823407966;11577.884221157849;3744.6817020553285;3783.148791521913;3831.616838316146;3907.179492306619;3937.3306537888343;56071.15893261605;56254.71872640611;56600.43399565993;56670;56994.43005569974;10954.616588419527;10968.405085523687;11021.889781102087;11025.724356891142;11202.271852329572;18887.622247554973;19048.71426928597;19133.330333438542;19175.616487670446;19453.513662158275;8321.209485098905;8337.95831020853;8349.8330033399;8418.663253469915;8420.705275315335;4557.635389168859;4611.608013318905;4635.496831710906;4642.86071417858;4770.95229047712;3221.3557288542384;3287.2110693433883;3287.2767991041933;3298.241404476984;3305.652906444837;553.9806106786324;557.0641322578108;564.7345747498669;581.682982774389;591.6538824787461;675.1223409567542;701.7789396340137;775.4998026273136;775.97672069838;793.3930543134506;9880.35777674449;10070.244731645156;10206.183505319557;10256.897431025744;10413.219008574388;582.6445868020504;634.5558109323492;684.5755631508497;688.3495097133161;727.3562896836232;4551.5676010778925;4621.098885717252;4669.486356500782;4679;4788.162071637449;66785.33214667888;67185.66407167933;67557;67558.3244167562;67885.3211467879;57531;57715.711421442626;58258.70870645619;59317.40682593119;59354.10968835471;48263;50365;50705.23942140871;51415;52378.47621523812;9117.452952822852;9158.038405967278;9160.267178625561;9330.113639204264;9433.386829856037;34947.30105397929;35072.64927350796;35587;35965;36322.27355452929;43956;48236.75881620569;48361.274580880614;48826;48901.5109848897;11617.709557261136;11705.239159454608;11776.76446471083;11806;12129.150959432754;12720.363981801058;13008.414621342252;13014.011272525084;13027.413766380347;13133.60599182026;11158.44207789591;11528.654140375802;11538.192326537062;11579.478923448634;11731.120165987755;12257.14200005991;12424.130310878152;12438.19151755133;12473;12547.74904501923;12087.576934807239;12270.263784172977;12480.251184928933;12487.375631218585;12554.623361299176;10325.74185645365;10659.25385223027;10726.141908647134;10746.301490403099;10894.782104358026;10166.745831354276;10651.840222396515;10691.732706682084;10775;10822.729431764268 06:16:59 INFO - PROCESS | 7389 | __end_tp_report 06:16:59 INFO - PROCESS | 7389 | __start_cc_report 06:16:59 INFO - PROCESS | 7389 | _x_x_mozilla_cycle_collect,338 06:16:59 INFO - PROCESS | 7389 | __end_cc_report 06:16:59 INFO - PROCESS | 7389 | __startTimestamp1461935819217__endTimestamp 06:16:59 INFO - PROCESS | 7389 | 06:16:59 INFO - PROCESS | 7389 | ------- Summary: start ------- 06:16:59 INFO - PROCESS | 7389 | Number of tests: 6 06:16:59 INFO - PROCESS | 7389 | 06:16:59 INFO - PROCESS | 7389 | [#0] dojo.html Cycles:165 Average:5305.09 Median:5544.09 stddev:697.50 (12.6%) stddev-sans-first:678.20 06:16:59 INFO - PROCESS | 7389 | Values: 3117.4 3193.7 3201.2 3223.1 3247.0 5337.3 5352.1 5385.6 5387.1 5435.9 5292.7 5381.0 5415.9 5473.4 5494.1 4907.4 4929.9 4979.3 5012.7 5026.5 608.7 4753.5 4857.4 4878.1 4973.0 4859.8 4869.1 4890.0 4895.5 4902.4 4843.6 4864.1 4886.7 4913.1 4943.1 4752.6 4859.1 4890.6 4911.6 4949.1 5277.1 5293.2 5300.1 5316.3 5371.1 5586.2 5774.2 5780.2 5790.9 5803.0 5735.2 5744.6 5765.1 5809.7 5825.8 5362.2 5371.8 5385.7 5386.6 5387.2 5673.9 5851.7 5852.5 5861.8 5888.7 5688.5 5694.6 5695.8 5700.8 5747.5 5760.3 5763.3 5777.9 5777.9 5791.9 5559.8 5693.1 5726.3 5754.3 5766.9 5667.3 5669.7 5681.7 5699.2 5715.5 4314.1 4337.5 4359.1 4360.1 4398.7 3824.8 3873.9 3881.8 3922.4 3946.7 5400.1 5425.7 5466.4 5467.8 5469.7 5705.3 5748.8 5770.2 5805.9 5816.8 5363.1 5500.6 5507.1 5559.3 5604.5 4915.9 4925.7 4928.4 4932.0 5003.1 5973.9 6005.5 6017.0 6018.4 6020.5 5586.6 5653.2 5704.5 5794.2 5823.2 5808.8 5813.3 5820.1 5823.4 5849.7 5514.6 5549.7 5592.1 5600.4 5615.7 5687.2 5707.1 5729.5 5749.9 5784.0 5521.4 5533.9 5547.1 5563.5 5568.6 5429.9 5533.4 5544.1 5576.0 5603.6 5513.7 5539.9 5550.5 5572.8 5595.8 5628.5 5634.5 5637.6 5671.1 5672.6 5383.5 5459.7 5522.5 5553.5 5581.4 06:16:59 INFO - PROCESS | 7389 | 06:16:59 INFO - PROCESS | 7389 | [#1] ext.html Cycles:180 Average:56237.47 Median:219222.70 stddev:111087.96 (50.7%) stddev-sans-first:111321.05 06:16:59 INFO - PROCESS | 7389 | Values: 600.6 641.0 653.2 656.2 668.4 37275.4 38224.6 38242.8 38398.0 38520.2 42947.8 43478.8 43668.3 43713.3 43749.1 8688.9 8913.7 8922.3 8937.1 8964.5 8769.8 8875.6 8895.2 8903.3 8919.3 8904.9 8987.3 8987.7 8995.7 9015.1 8830.3 8836.9 8917.8 8937.6 8950.9 8662.4 8714.4 8764.0 8764.4 8794.6 29951.9 39830.4 39863.6 40087.0 40168.4 3328.5 3473.3 3649.4 3696.9 4353.3 30517.4 31917.4 33306.8 33535.2 34114.1 4135.7 4327.8 4330.3 4370.9 4477.8 302128.0 306933.0 309165.0 310238.0 310288.0 34030.0 34976.0 65666.0 66218.7 66375.0 38343.6 38361.6 38551.8 38607.4 38615.0 14745.8 14933.9 14949.0 14985.2 15013.7 12496.8 12617.0 12632.7 12641.0 12697.9 8682.5 8713.2 8737.3 8758.9 8792.5 3471.8 3505.1 3515.7 3543.7 3545.1 1047.3 1094.9 1123.9 1126.8 1170.4 32653.8 32788.5 33021.7 33417.3 33937.2 1085.3 1129.6 1151.7 1205.9 1274.1 15295.0 15761.9 16392.2 16415.0 16841.9 515327.0 516813.0 519156.0 520685.0 523984.0 58519.7 59444.7 59513.7 59541.4 59685.4 1400.8 1451.1 1455.2 1459.1 1567.1 30309.0 30754.5 30766.5 30965.8 30984.8 49320.3 49583.5 49683.0 49892.0 49939.0 398615.0 399083.0 401610.0 404091.0 404183.0 28669.5 29030.3 29774.6 29940.6 30068.2 48273.3 49136.3 49328.8 49373.5 49905.0 41482.1 41675.0 41751.0 41837.4 43616.3 41893.4 43031.4 43146.0 43265.6 44028.3 36403.0 37571.0 38454.4 41808.8 43784.9 32492.5 33445.8 35136.0 35504.8 35733.8 27614.3 28317.4 28350.8 28388.2 28590.1 06:16:59 INFO - PROCESS | 7389 | 06:16:59 INFO - PROCESS | 7389 | [#2] jquery.html Cycles:180 Average:27758.68 Median:19761.73 stddev:75620.59 (382.7%) stddev-sans-first:75804.81 06:16:59 INFO - PROCESS | 7389 | Values: 394.6 395.3 396.3 398.8 414.1 14524.6 18197.5 18698.9 18902.2 18929.2 17840.5 18016.3 18276.1 18856.4 18963.9 5060.5 5186.4 5751.5 5914.7 5915.1 5806.5 5810.2 5849.7 5853.9 5855.5 5284.8 5299.6 5318.0 5325.5 5729.0 5192.5 5219.9 5266.2 5268.3 5292.7 4965.2 5274.2 5279.8 5291.5 5296.8 13048.5 13542.0 13583.9 20485.8 22736.8 2194.9 2212.7 2346.9 2428.9 2441.6 9234.6 10392.4 10743.2 13735.2 14907.1 1971.8 1976.6 1997.5 2008.7 2033.5 78903.0 79682.2 79884.6 80050.0 80919.6 10636.7 10715.6 10793.5 10855.0 10941.7 14667.5 14755.3 14855.1 29957.7 31328.0 9270.9 9335.5 9435.9 9451.1 9506.7 7607.9 7728.9 8012.1 8049.1 8149.2 8671.2 8913.9 8973.6 8994.6 9073.0 3435.8 3535.3 3559.8 3615.4 3737.0 932.5 1040.5 1042.9 1083.7 1118.8 18663.3 18859.2 18926.5 19676.1 19696.2 1008.9 1021.5 1042.5 1043.1 1116.1 10447.2 10496.9 10745.3 10792.4 11015.0 434415.0 437593.0 456408.0 478940.0 479211.0 84871.0 86667.6 87560.1 98879.0 104686.0 466.9 484.4 486.5 487.6 489.1 10202.3 10476.7 10742.2 10872.8 11077.7 35908.1 37581.4 37789.4 38653.4 39496.0 49734.5 53710.0 54719.5 56070.4 56840.7 8181.1 8381.3 8417.9 8496.8 8586.7 9283.5 11121.6 12380.3 13288.7 13423.6 11847.8 11857.2 11903.6 12020.3 12193.2 11277.7 11662.2 11699.0 11877.9 12096.8 12041.9 12046.2 12277.2 12330.6 12532.6 8706.0 8831.0 8911.7 8912.4 9038.9 8567.3 10808.3 11549.4 11579.0 11607.3 06:16:59 INFO - PROCESS | 7389 | 06:16:59 INFO - PROCESS | 7389 | [#3] mootools.html Cycles:180 Average:5219.81 Median:5004.88 stddev:2834.61 (56.6%) stddev-sans-first:2829.01 06:16:59 INFO - PROCESS | 7389 | Values: 1530.9 1532.7 1699.5 1761.1 1812.8 7082.5 7592.9 7612.8 7940.8 7944.2 7665.5 7677.7 7701.2 7702.4 7763.5 2129.1 2165.5 2167.7 2169.7 2171.6 2048.6 2058.6 2071.4 2078.4 2084.5 2070.0 2070.0 2081.7 2085.9 2090.8 2015.0 2030.4 2040.9 2041.2 2043.0 2036.7 2050.3 2090.7 2092.3 2098.3 7828.8 7871.1 7878.4 7893.0 7897.2 4618.1 4774.4 4794.1 4815.0 4825.3 3062.1 3090.8 3130.9 3145.9 3148.4 1059.1 1078.6 1092.0 1111.1 1121.7 10323.6 10356.4 10373.1 10380.4 10417.3 4153.0 4168.0 4242.5 4251.3 4269.3 8962.5 8975.7 8977.0 8985.3 8989.1 4740.1 4753.8 4775.1 4809.9 4810.7 3854.6 4343.9 4417.9 4479.3 4509.4 3520.3 3544.3 3555.8 3608.1 3652.3 1116.9 1155.2 1157.9 1159.3 1159.7 1004.2 1007.9 1019.3 1023.7 1031.4 5588.8 5620.4 5663.0 5751.4 5883.2 957.0 967.2 981.4 994.7 1048.9 4152.4 4180.9 4203.9 4259.9 4272.8 9258.6 9609.9 9688.4 9693.5 9718.0 9555.3 9581.5 9605.6 9662.5 9668.6 7054.3 7323.1 7361.2 7363.3 7397.2 5401.9 5689.4 5778.5 5784.7 5822.4 8618.7 9010.3 9032.2 9097.7 9139.8 8965.5 9040.5 9132.9 9281.4 9285.7 6268.9 6771.3 7041.7 7051.0 7156.1 7536.3 7556.1 7573.6 7601.7 7613.4 6546.2 6701.4 6720.6 6729.8 6793.9 6535.6 6564.3 6632.1 6638.7 6652.9 6115.7 6233.2 6254.7 6257.7 6263.6 4883.7 4902.0 4994.0 5015.7 5115.3 4862.8 4950.2 5101.4 5163.0 5245.4 06:16:59 INFO - PROCESS | 7389 | 06:16:59 INFO - PROCESS | 7389 | [#4] prototype.html Cycles:180 Average:4985.07 Median:5710.49 stddev:1538.30 (26.9%) stddev-sans-first:1502.32 06:16:59 INFO - PROCESS | 7389 | Values: 324.6 325.9 332.0 335.1 336.5 5498.3 5558.6 5584.3 5611.2 5627.2 5455.2 5461.5 5500.5 5511.4 5526.8 4064.7 4098.1 4218.3 4240.6 4277.7 4197.9 4224.3 4234.9 4238.9 4264.1 4199.2 4203.2 4218.8 4239.2 4248.6 4079.5 4245.7 4254.7 4259.3 4262.6 3699.0 3716.9 3730.5 3731.8 3739.7 5255.5 5276.4 5290.3 5301.7 5323.3 4708.1 4808.8 4847.4 4900.5 4910.5 5699.1 5735.6 5753.8 5786.7 5788.5 4101.6 4114.0 4116.5 4126.2 4132.4 5653.7 6058.3 6066.3 6081.9 6113.4 4056.7 4093.8 4103.3 4104.3 4118.4 4098.7 4110.5 4121.7 4139.6 4143.9 4560.7 4768.8 4773.6 4801.1 4820.8 5783.0 5824.5 5827.9 5841.7 5862.6 1493.5 1498.5 1506.5 1511.8 1516.1 913.5 967.6 984.7 991.7 997.3 5926.5 5938.4 5943.8 5951.1 5957.4 6239.6 6247.8 6275.8 6365.7 6404.5 5798.4 5834.3 5896.6 5905.4 5940.8 3348.6 3357.2 3372.7 3382.8 3402.5 6390.4 6468.5 6523.2 6551.4 6577.9 6446.8 6447.6 6448.5 6451.2 6459.5 6332.2 6497.7 6533.2 6579.4 6592.8 6273.8 6274.7 6302.4 6318.8 6327.9 6179.7 6270.1 6282.2 6297.3 6309.0 6432.7 6477.9 6505.0 6520.0 6550.8 4252.8 4268.4 4283.9 4290.1 4294.1 6253.9 6275.4 6323.6 6347.5 6372.8 6075.5 6128.7 6130.2 6185.4 6188.5 5947.7 6133.2 6157.8 6176.2 6200.6 5444.2 5544.3 5691.5 6010.7 6034.9 5820.5 5860.7 5871.8 5886.2 5890.4 5559.8 5721.8 5797.3 5797.7 5818.1 06:16:59 INFO - PROCESS | 7389 | 06:16:59 INFO - PROCESS | 7389 | [#5] yui.html Cycles:180 Average:15234.82 Median:4554.60 stddev:18034.69 (396.0%) stddev-sans-first:18052.46 06:16:59 INFO - PROCESS | 7389 | Values: 744.1 797.1 820.7 823.9 851.7 14351.3 14638.2 14677.9 14910.1 14911.3 13566.7 13678.2 13683.2 13695.7 13750.1 836.1 867.8 869.7 870.3 872.8 846.6 853.3 853.6 856.3 858.2 895.9 896.9 899.9 902.1 902.5 887.6 891.8 894.6 896.9 901.4 649.0 654.3 655.1 655.6 658.7 14619.9 14655.0 14727.3 14751.0 14780.7 13632.7 13783.5 14030.0 14068.7 14095.3 11418.0 11530.4 11547.7 11559.5 11577.9 3744.7 3783.1 3831.6 3907.2 3937.3 56071.2 56254.7 56600.4 56670.0 56994.4 10954.6 10968.4 11021.9 11025.7 11202.3 18887.6 19048.7 19133.3 19175.6 19453.5 8321.2 8338.0 8349.8 8418.7 8420.7 4557.6 4611.6 4635.5 4642.9 4771.0 3221.4 3287.2 3287.3 3298.2 3305.7 554.0 557.1 564.7 581.7 591.7 675.1 701.8 775.5 776.0 793.4 9880.4 10070.2 10206.2 10256.9 10413.2 582.6 634.6 684.6 688.3 727.4 4551.6 4621.1 4669.5 4679.0 4788.2 66785.3 67185.7 67557.0 67558.3 67885.3 57531.0 57715.7 58258.7 59317.4 59354.1 48263.0 50365.0 50705.2 51415.0 52378.5 9117.5 9158.0 9160.3 9330.1 9433.4 34947.3 35072.6 35587.0 35965.0 36322.3 43956.0 48236.8 48361.3 48826.0 48901.5 11617.7 11705.2 11776.8 11806.0 12129.2 12720.4 13008.4 13014.0 13027.4 13133.6 11158.4 11528.7 11538.2 11579.5 11731.1 12257.1 12424.1 12438.2 12473.0 12547.7 12087.6 12270.3 12480.3 12487.4 12554.6 10325.7 10659.3 10726.1 10746.3 10894.8 10166.7 10651.8 10691.7 10775.0 10822.7 06:16:59 INFO - PROCESS | 7389 | -------- Summary: end -------- 06:16:59 INFO - PROCESS | 7389 | 06:16:59 INFO - TEST-INFO | 7389: exit 0 06:16:59 INFO - TEST-OK | dromaeo_css | took 1109096ms 06:16:59 INFO - TEST-START | kraken 06:16:59 INFO - operating with platform_type : linux_ 06:16:59 INFO - Initialising browser for kraken test... 06:16:59 INFO - TEST-INFO | started process 7620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpagAeOa/profile http://localhost:58482/getInfo.html) 06:17:03 INFO - PROCESS | 7620 | 06:17:03 INFO - PROCESS | 7620 | (process:7689): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:17:04 INFO - PROCESS | 7620 | __metrics Screen width/height:1600/1200 06:17:04 INFO - PROCESS | 7620 | colorDepth:24 06:17:04 INFO - PROCESS | 7620 | Browser inner width/height: 1024/697 06:17:04 INFO - PROCESS | 7620 | __metrics 06:17:04 ERROR - PROCESS | 7620 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:17:05 INFO - TEST-INFO | 7620: exit 0 06:17:05 INFO - Browser initialized. 06:17:05 INFO - Running cycle 1/1 for kraken test... 06:17:05 INFO - TEST-INFO | started process 7740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpagAeOa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:07 INFO - PROCESS | 7740 | 06:17:07 INFO - PROCESS | 7740 | (process:7803): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:17:17 INFO - PROCESS | 7740 | RSS: Main: 164970496 06:17:17 INFO - PROCESS | 7740 | 06:17:19 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58482/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:20 INFO - PROCESS | 7740 | RSS: Main: 169582592 06:17:20 INFO - PROCESS | 7740 | 06:17:23 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58482/tests/kraken/driver.html?testName=audio-dft) 06:17:24 INFO - PROCESS | 7740 | RSS: Main: 173043712 06:17:24 INFO - PROCESS | 7740 | 06:17:26 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58482/tests/kraken/driver.html?testName=audio-fft) 06:17:27 INFO - PROCESS | 7740 | RSS: Main: 164851712 06:17:27 INFO - PROCESS | 7740 | 06:17:29 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58482/tests/kraken/driver.html?testName=audio-oscillator) 06:17:30 INFO - PROCESS | 7740 | RSS: Main: 164339712 06:17:30 INFO - PROCESS | 7740 | 06:17:32 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:17:33 INFO - PROCESS | 7740 | RSS: Main: 164646912 06:17:33 INFO - PROCESS | 7740 | 06:17:36 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58482/tests/kraken/driver.html?testName=imaging-darkroom) 06:17:36 INFO - PROCESS | 7740 | RSS: Main: 165068800 06:17:36 INFO - PROCESS | 7740 | 06:17:40 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58482/tests/kraken/driver.html?testName=imaging-desaturate) 06:17:40 INFO - PROCESS | 7740 | RSS: Main: 165294080 06:17:40 INFO - PROCESS | 7740 | 06:17:43 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58482/tests/kraken/driver.html?testName=json-parse-financial) 06:17:44 INFO - PROCESS | 7740 | RSS: Main: 167743488 06:17:44 INFO - PROCESS | 7740 | 06:17:45 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:17:46 INFO - PROCESS | 7740 | RSS: Main: 167694336 06:17:46 INFO - PROCESS | 7740 | 06:17:48 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58482/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:17:48 INFO - PROCESS | 7740 | RSS: Main: 167469056 06:17:48 INFO - PROCESS | 7740 | 06:17:50 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:17:51 INFO - PROCESS | 7740 | RSS: Main: 167530496 06:17:51 INFO - PROCESS | 7740 | 06:17:54 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:17:54 INFO - PROCESS | 7740 | RSS: Main: 167985152 06:17:54 INFO - PROCESS | 7740 | 06:17:57 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:58 INFO - PROCESS | 7740 | RSS: Main: 168177664 06:17:58 INFO - PROCESS | 7740 | 06:17:59 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:58482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58482/tests/kraken/driver.html?testName=ai-astar) 06:18:00 INFO - PROCESS | 7740 | RSS: Main: 169578496 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | __start_tp_report 06:18:00 INFO - PROCESS | 7740 | _x_x_mozilla_page_load 06:18:00 INFO - PROCESS | 7740 | _x_x_mozilla_page_load_details 06:18:00 INFO - PROCESS | 7740 | |i|pagename|runs| 06:18:00 INFO - PROCESS | 7740 | |0;ai-astar;111;108;118;110;116;124;112;111;113;112 06:18:00 INFO - PROCESS | 7740 | |1;audio-beat-detection;151;128;159;181;127;158;158;132;184;137 06:18:00 INFO - PROCESS | 7740 | |2;audio-dft;161;161;161;163;161;166;172;162;165;162 06:18:00 INFO - PROCESS | 7740 | |3;audio-fft;72;76;77;162;77;76;77;75;169;77 06:18:00 INFO - PROCESS | 7740 | |4;audio-oscillator;92;93;148;92;93;93;157;92;94;148 06:18:00 INFO - PROCESS | 7740 | |5;imaging-gaussian-blur;117;119;118;117;121;117;118;117;118;118 06:18:00 INFO - PROCESS | 7740 | |6;imaging-darkroom;147;147;148;147;146;147;146;147;147;147 06:18:00 INFO - PROCESS | 7740 | |7;imaging-desaturate;95;95;97;95;95;95;95;95;95;96 06:18:00 INFO - PROCESS | 7740 | |8;json-parse-financial;59;62;58;58;63;63;58;73;58;56 06:18:00 INFO - PROCESS | 7740 | |9;json-stringify-tinderbox;61;62;61;62;62;61;61;61;61;61 06:18:00 INFO - PROCESS | 7740 | |10;stanford-crypto-aes;79;78;78;78;78;79;79;79;80;78 06:18:00 INFO - PROCESS | 7740 | |11;stanford-crypto-ccm;126;126;135;127;134;132;129;141;167;135 06:18:00 INFO - PROCESS | 7740 | |12;stanford-crypto-pbkdf2;167;167;167;166;172;165;169;166;176;166 06:18:00 INFO - PROCESS | 7740 | |13;stanford-crypto-sha256-iterative;68;69;68;69;68;68;67;68;67;66 06:18:00 INFO - PROCESS | 7740 | __end_tp_report 06:18:00 INFO - PROCESS | 7740 | __start_cc_report 06:18:00 INFO - PROCESS | 7740 | _x_x_mozilla_cycle_collect,842 06:18:00 INFO - PROCESS | 7740 | __end_cc_report 06:18:00 INFO - PROCESS | 7740 | __startTimestamp1461935880046__endTimestamp 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | ------- Summary: start ------- 06:18:00 INFO - PROCESS | 7740 | Number of tests: 14 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#0] ai-astar Cycles:10 Average:113.50 Median:112.50 stddev:4.67 (4.2%) stddev-sans-first:4.87 06:18:00 INFO - PROCESS | 7740 | Values: 111.0 108.0 118.0 110.0 116.0 124.0 112.0 111.0 113.0 112.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:158.00 stddev:20.58 (13.0%) stddev-sans-first:21.82 06:18:00 INFO - PROCESS | 7740 | Values: 151.0 128.0 159.0 181.0 127.0 158.0 158.0 132.0 184.0 137.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#2] audio-dft Cycles:10 Average:163.40 Median:162.50 stddev:3.50 (2.2%) stddev-sans-first:3.61 06:18:00 INFO - PROCESS | 7740 | Values: 161.0 161.0 161.0 163.0 161.0 166.0 172.0 162.0 165.0 162.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.50 stddev:37.86 (49.5%) stddev-sans-first:39.32 06:18:00 INFO - PROCESS | 7740 | Values: 72.0 76.0 77.0 162.0 77.0 76.0 77.0 75.0 169.0 77.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:92.50 stddev:28.27 (30.6%) stddev-sans-first:29.21 06:18:00 INFO - PROCESS | 7740 | Values: 92.0 93.0 148.0 92.0 93.0 93.0 157.0 92.0 94.0 148.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.25 (1.1%) stddev-sans-first:1.27 06:18:00 INFO - PROCESS | 7740 | Values: 117.0 119.0 118.0 117.0 121.0 117.0 118.0 117.0 118.0 118.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 06:18:00 INFO - PROCESS | 7740 | Values: 147.0 147.0 148.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:18:00 INFO - PROCESS | 7740 | Values: 95.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:60.50 stddev:4.92 (8.1%) stddev-sans-first:5.17 06:18:00 INFO - PROCESS | 7740 | Values: 59.0 62.0 58.0 58.0 63.0 63.0 58.0 73.0 58.0 56.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 06:18:00 INFO - PROCESS | 7740 | Values: 61.0 62.0 61.0 62.0 62.0 61.0 61.0 61.0 61.0 61.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:0.70 (0.9%) stddev-sans-first:0.73 06:18:00 INFO - PROCESS | 7740 | Values: 79.0 78.0 78.0 78.0 78.0 79.0 79.0 79.0 80.0 78.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:134.50 stddev:12.16 (9.0%) stddev-sans-first:12.44 06:18:00 INFO - PROCESS | 7740 | Values: 126.0 126.0 135.0 127.0 134.0 132.0 129.0 141.0 167.0 135.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:167.00 stddev:3.41 (2.0%) stddev-sans-first:3.60 06:18:00 INFO - PROCESS | 7740 | Values: 167.0 167.0 167.0 166.0 172.0 165.0 169.0 166.0 176.0 166.0 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - PROCESS | 7740 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 06:18:00 INFO - PROCESS | 7740 | Values: 68.0 69.0 68.0 69.0 68.0 68.0 67.0 68.0 67.0 66.0 06:18:00 INFO - PROCESS | 7740 | -------- Summary: end -------- 06:18:00 INFO - PROCESS | 7740 | 06:18:00 INFO - TEST-INFO | 7740: exit 0 06:18:00 INFO - TEST-OK | kraken | took 61099ms 06:18:00 INFO - SUITE-END | took 1170s 06:18:01 INFO - Completed test suite (00:19:30) 06:18:01 INFO - javascript benchmark 06:18:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.392108538835, 3193.712565869071, 3201.1516948008775, 3223.081421794789, 3246.9512957305647, 5337.252784610153, 5352.116900711388, 5385.649932754373, 5387.057264978628, 5435.864103397417, 5292.682439053659, 5381.0, 5415.918761218575, 5473.425290344516, 5494.120940649497, 4907.435644900837, 4929.876753081166, 4979.30289759434, 5012.706512025013, 5026.547610715035, 608.6743013277759, 4753.548412900769, 4857.368542089541, 4878.097551952882, 4973.030259099477, 4859.829905953292, 4869.123557759602, 4890.046440944017, 4895.485973972735, 4902.436219834729, 4843.564079232886, 4864.148773964542, 4886.657933944625, 4913.091078150518, 4943.134951383494, 4752.619790416758, 4859.125357435661, 4890.608751299887, 4911.607071434277, 4949.133901567211, 5277.050130976423, 5293.206019097166, 5300.09898317287, 5316.308879845634, 5371.113766228567, 5586.16207568868, 5774.162746401748, 5780.248567686216, 5790.913136302959, 5802.97098514509, 5735.1970724098655, 5744.597878148531, 5765.106408506646, 5809.738561764731, 5825.825225243249, 5362.222477740745, 5371.785128594852, 5385.7307134643115, 5386.649867758583, 5387.164989426606, 5673.914891276634, 5851.736671849777, 5852.473277404969, 5861.794837180763, 5888.735006924699, 5688.54491640676, 5694.601377903507, 5695.829125126253, 5700.828975130753, 5747.5114615257335, 5760.308762948473, 5763.279590051244, 5777.8555536111935, 5777.88444231113, 5791.913121303184, 5559.833205003856, 5693.117566777156, 5726.341470730836, 5754.280714910637, 5766.942330576724, 5667.319921609434, 5669.659820410789, 5681.744321505542, 5699.230603868425, 5715.485606295453, 4314.115606300701, 4337.50118736343, 4359.14996575671, 4360.127974405068, 4398.73607583546, 3824.808759562011, 3873.8644147455266, 3881.844726210976, 3922.392029235416, 3946.664533514626, 5400.135978243462, 5425.728713564306, 5466.371367292732, 5467.835964921059, 5469.726513674301, 5705.343885453143, 5748.798792042258, 5770.221020162308, 5805.88388232233, 5816.82549523515, 5363.088274993261, 5500.559955203574, 5507.118860982224, 5559.277293951841, 5604.467575580395, 4915.877103072452, 4925.729084900365, 4928.383952005999, 4931.9753401232765, 5003.074431230234, 5973.910391344133, 6005.459508644243, 6017.037274036134, 6018.428249316308, 6020.458158765732, 5586.636868603609, 5653.1802888580105, 5704.543636508986, 5794.188813566188, 5823.242978412779, 5808.796692115756, 5813.302403711582, 5820.097884827858, 5823.388544202798, 5849.678267695318, 5514.641548299348, 5549.722513874371, 5592.105263157875, 5600.439956004367, 5615.691136987505, 5687.20379146928, 5707.086866101404, 5729.455701708331, 5749.91375129365, 5784.0, 5521.4478552144465, 5533.861653458695, 5547.112462006221, 5563.471470210324, 5568.610197286151, 5429.864253393696, 5533.446655334435, 5544.085225937675, 5576.0, 5603.607747457639, 5513.669179849222, 5539.916901246565, 5550.5282051026115, 5572.832815015556, 5595.832125036255, 5628.521575666115, 5634.52106570946, 5637.577181711306, 5671.149327600728, 5672.631278966854, 5383.488568585978, 5459.727013649381, 5522.502974732293, 5553.4724201200825, 5581.358143813513], "value": 5261.146876067055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.6006006006006, 640.9936399852232, 653.225927276178, 656.2223764838665, 668.3583759590792, 37275.44086838696, 38224.61775382242, 38242.8087859561, 38398.0, 38520.22959540808, 42947.78526107373, 43478.78260608693, 43668.344974825406, 43713.34429983545, 43749.12501749971, 8688.913110868889, 8913.732588022369, 8922.330825188104, 8937.106289371075, 8964.50695211763, 8769.7807554811, 8875.556222188898, 8895.243904268145, 8903.287736981027, 8919.286457083417, 8904.910950890473, 8987.281017518615, 8987.730368088967, 8995.685151019716, 9015.14356136166, 8830.293576513863, 8836.8674469883, 8917.821643567126, 8937.553122343921, 8950.910490895105, 8662.350323725746, 8714.389992700513, 8764.0, 8764.386492945496, 8794.648214071494, 29951.850240748656, 39830.40254396186, 39863.60136398657, 40086.99782505431, 40168.39747403791, 3328.484084966834, 3473.3400653875683, 3649.416093425066, 3696.907577310562, 4353.28170851809, 30517.389652207054, 31917.361652767046, 33306.83346583252, 33535.16162095943, 34114.147146321295, 4135.710500264982, 4327.826886924519, 4330.30715085588, 4370.912581748347, 4477.843275485375, 302128.0, 306933.0, 309165.0, 310238.0, 310288.0, 34030.0, 34976.0, 65666.0, 66218.66890665612, 66375.02624763794, 38343.616563834, 38361.616383836365, 38551.807240963615, 38607.42088868669, 38615.0, 14745.77881331781, 14933.850661493247, 14949.0, 14985.175815330043, 15013.69972600542, 12496.81254781179, 12617.0, 12632.747345053047, 12640.988720902305, 12697.93651031739, 8682.479051256818, 8713.172248636369, 8737.30101591871, 8758.86861697075, 8792.516411597295, 3471.7916924984584, 3505.088676944013, 3515.736319776027, 3543.7342199335153, 3545.1314427965312, 1047.272145858621, 1094.9069329106956, 1123.904468120219, 1126.8253420719802, 1170.3913964738288, 32653.836730816194, 32788.508172377435, 33021.66978330186, 33417.3316533668, 33937.15157121092, 1085.2999815119363, 1129.6102844518628, 1151.6545036489188, 1205.9336736479577, 1274.095392271479, 15295.0, 15761.921190393974, 16392.180390980404, 16415.0, 16841.915790421215, 515327.0, 516813.0, 519156.0, 520685.0, 523984.0, 58519.70740146357, 59444.70277648671, 59513.70243148757, 59541.40458595358, 59685.403145968856, 1400.7688731359415, 1451.083322521718, 1455.2432734977751, 1459.1245252848419, 1567.1067491529946, 30309.0, 30754.53868191934, 30766.538501922936, 30965.845170774002, 30984.845075774476, 49320.260196097806, 49583.504164957885, 49683.0, 49892.0, 49939.0, 398615.0, 399083.0, 401610.0, 404091.0, 404183.0, 28669.521926207475, 29030.27424314409, 29774.553381698857, 29940.550891736206, 30068.24829379283, 48273.27590086081, 49136.262956054976, 49328.753356234425, 49373.50626493689, 49905.0, 41482.05920437554, 41675.0, 41750.956226093374, 41837.372439414044, 43616.34575481307, 41893.371599426646, 43031.35452968271, 43146.0, 43265.567344326155, 44028.33957490576, 36403.0, 37571.0, 38454.42318365283, 41808.79095604503, 43784.90537736582, 32492.512612310362, 33445.83277083599, 35136.0, 35504.82247588746, 35733.82133089318, 27614.309642259104, 28317.433651327272, 28350.76283217689, 28388.194555007394, 28590.142295731162], "value": 18866.938662787885, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.5521832719864, 395.2509993562199, 396.2550405238152, 398.8484375937144, 414.0848724319254, 14524.636884077903, 18197.545061373472, 18698.906505467487, 18902.24391024359, 18929.24283028679, 17840.46478605644, 18016.279348826065, 18276.08619569023, 18856.434306970812, 18963.905180474114, 5060.519250671189, 5186.403563590179, 5751.511121554652, 5914.733836977346, 5915.112733090049, 5806.477417032466, 5810.24466819315, 5849.707514624273, 5853.853653658672, 5855.531557475413, 5284.762185701634, 5299.60252981026, 5318.0161670090965, 5325.467453254682, 5728.971355143219, 5192.480751924796, 5219.921701174486, 5266.183741520071, 5268.262443257928, 5292.708901010443, 4965.230389289666, 5274.156135018378, 5279.841604751864, 5291.497307755757, 5296.814611488579, 13048.543300984515, 13541.984351173603, 13583.932080339633, 20485.795142048686, 22736.77263227363, 2194.8902554872193, 2212.712347394828, 2346.9061237550477, 2428.9392765180837, 2441.6215486599604, 9234.584443700049, 10392.428416437093, 10743.247972641919, 13735.175889446666, 14907.105573665507, 1971.8225359717694, 1976.594798066393, 1997.470670272379, 2008.6685696860147, 2033.522122301258, 78903.0, 79682.20317796805, 79884.60057699675, 80050.0, 80919.5954020232, 10636.680899573024, 10715.624953126604, 10793.460326983619, 10854.960611028924, 10941.671749847517, 14667.48663796762, 14755.262236888113, 14855.108693478425, 29957.70042299549, 31328.0, 9270.887493500688, 9335.486548239913, 9435.905640943503, 9451.149396554343, 9506.667266645773, 7607.885881711779, 7728.884066739003, 8012.0786109596975, 8049.074356448966, 8149.225823546753, 8671.176238257356, 8913.910860891438, 8973.564229723213, 8994.550272486349, 9072.95463522678, 3435.7766745161484, 3535.275268569937, 3559.7864128152396, 3615.367310720666, 3736.962630373716, 932.5011119051275, 1040.4641609571077, 1042.921780866438, 1083.653230966099, 1118.798616249083, 18663.346782862536, 18859.151338189815, 18926.526836828914, 19676.114574844167, 19696.212151514064, 1008.8587597736323, 1021.4841505040056, 1042.4943902207424, 1043.0560342889696, 1116.0792346314324, 10447.164226861833, 10496.947515262527, 10745.301555398873, 10792.406417646947, 11015.0, 434415.0, 437593.0, 456408.0, 478940.0, 479211.0, 84871.0, 86667.56666216755, 87560.12439875647, 98879.0, 104686.0, 466.9463011753692, 484.41869756291885, 486.45031114840714, 487.5611949245707, 489.104937963533, 10202.33684810485, 10476.68569942903, 10742.194335424718, 10872.782544349227, 11077.72305692332, 35908.10229744173, 37581.4362784553, 37789.43315850209, 38653.420198696476, 39496.0, 49734.50265497299, 53710.0, 54719.452805473025, 56070.43929560652, 56840.71579642075, 8181.140980196994, 8381.329493640616, 8417.915820841958, 8496.830063398822, 8586.742397728078, 9283.48940808262, 11121.555137794398, 12380.319082450551, 13288.734225315633, 13423.597292081253, 11847.822282665595, 11857.16999810005, 11903.642890713292, 12020.278783273032, 12193.207441516273, 11277.661670149908, 11662.241954272946, 11699.0, 11877.881221187678, 12096.818547721616, 12041.879581204075, 12046.156769026084, 12277.201981871507, 12330.568430105262, 12532.624021279376, 8706.0, 8830.955845220733, 8911.688090916787, 8912.376133670581, 9038.864417033881, 8567.314614830922, 10808.297460665031, 11549.364784936573, 11579.0, 11607.30356178632], "value": 9153.926469679313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.9311081001354, 1532.6704758476926, 1699.4816580942806, 1761.1282415204475, 1812.8277813607704, 7082.539634923726, 7592.8861067084035, 7612.847743045136, 7940.801479963004, 7944.205579442053, 7665.4634175607725, 7677.65450554725, 7701.152873183959, 7702.42231832612, 7763.534187948727, 2129.0525716056363, 2165.4911095892453, 2167.7398712154563, 2169.652855543113, 2171.554831259596, 2048.5902819436096, 2058.619155456238, 2071.3682326890294, 2078.449210959097, 2084.47888027993, 2069.9586008279825, 2069.9896500517552, 2081.739782527184, 2085.9269925552608, 2090.80137386948, 2015.042854644047, 2030.4010316956533, 2040.9489762755902, 2041.1937284772505, 2043.039771307483, 2036.7352244208157, 2050.261905713942, 2090.707300977864, 2092.3199960013058, 2098.3390232076845, 7828.765137045841, 7871.055473343178, 7878.4485086044, 7892.960535197287, 7897.210278972057, 4618.099470603233, 4774.40319960005, 4794.089123066641, 4814.951850481485, 4825.324454576362, 3062.096681478969, 3090.8454577271273, 3130.89041883533, 3145.905622831319, 3148.370325934822, 1059.0944742245424, 1078.563181911327, 1091.9727006824894, 1111.111111111108, 1121.6915348279206, 10323.638672646497, 10356.378617282988, 10373.11828494579, 10380.377177369306, 10417.322874013165, 4152.958470415258, 4167.9583204168175, 4242.53332133465, 4251.256030194703, 4269.31690929456, 8962.462252264884, 8975.685850995314, 8976.955115224382, 8985.326100542485, 8989.10108989109, 4740.1230772307235, 4753.786079626425, 4775.06886157196, 4809.879753006203, 4810.687305325213, 3854.5952674968726, 4343.891402714958, 4417.933730994037, 4479.260921947842, 4509.436320459942, 3520.3487354839435, 3544.3442963051916, 3555.7866528008403, 3608.1340478285024, 3652.251288485854, 1116.8883111688765, 1155.2029099921028, 1157.8784227655974, 1159.287038471334, 1159.675290918544, 1004.1565085328214, 1007.8992100789862, 1019.2712210769336, 1023.7184774187158, 1031.4120951057826, 5588.804391846347, 5620.353659329147, 5662.971685141548, 5751.396103409165, 5883.235179426647, 957.0, 967.2213867836318, 981.3817295104182, 994.7363948553639, 1048.905598496139, 4152.37714342851, 4180.895477613023, 4203.936940945889, 4259.914801703949, 4272.829086836492, 9258.629654813867, 9609.90390096104, 9688.370255933341, 9693.466859322805, 9718.028197180367, 9555.331126821195, 9581.473018984023, 9605.615775368908, 9662.516874156265, 9668.613255469703, 7054.294570542905, 7323.084614423197, 7361.190269070505, 7363.337299643058, 7397.18630950595, 5401.918971215357, 5689.374168841507, 5778.537716982547, 5784.739686714024, 5822.359540450462, 8618.741437756877, 9010.279177665901, 9032.232260257952, 9097.727068187965, 9139.817203655757, 8965.462072275684, 9040.502772347583, 9132.863007054766, 9281.350305478552, 9285.72142835716, 6268.874622507616, 6771.322867713189, 7041.6831242595235, 7050.964745176241, 7156.069710937545, 7536.321731044013, 7556.093268807778, 7573.621318933921, 7601.695932162652, 7613.390928725799, 6546.223601121274, 6701.396874281338, 6720.630365329954, 6729.764458243938, 6793.898091528532, 6535.57518761279, 6564.277929427663, 6632.071509988509, 6638.734450621921, 6652.866942661217, 6115.663638499926, 6233.2208473940755, 6254.718537665725, 6257.749690012349, 6263.6241825490615, 4883.658143929891, 4901.950980490149, 4994.02616489781, 5015.724135172601, 5115.283860259492, 4862.805487780449, 4950.183219768698, 5101.387833460009, 5163.044836705071, 5245.423003469539], "value": 4258.772287003674, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.57480700282633, 325.8696521391445, 331.97842140260883, 335.0534739361305, 336.48349783082955, 5498.285222921019, 5558.610897237195, 5584.274044374226, 5611.164389035398, 5627.184058311543, 5455.18172274159, 5461.481159289871, 5500.532454741352, 5511.421300763423, 5526.834194974147, 4064.7154699170997, 4098.098418347973, 4218.303979843337, 4240.62179791569, 4277.700560960734, 4197.8530751423705, 4224.324108142698, 4234.894127646818, 4238.936415953764, 4264.083222107246, 4199.2441360555085, 4203.159368126372, 4218.755467137186, 4239.1521695660995, 4248.638865696404, 4079.5104587449546, 4245.702800803945, 4254.659627229814, 4259.339802330644, 4262.6376757975295, 3699.0, 3716.9035134635346, 3730.515033045687, 3731.7574357666663, 3739.700823934079, 5255.500727430888, 5276.419593844674, 5290.312259406252, 5301.6818990860675, 5323.281357016792, 4708.085733782955, 4808.75956202192, 4847.418309802811, 4900.534449227318, 4910.508949105097, 5699.145128230757, 5735.569832262555, 5753.827385178452, 5786.652800831921, 5788.5369170466265, 4101.569335219819, 4113.9794301028605, 4116.547179810218, 4126.195391898581, 4132.421460995463, 5653.689047102408, 6058.333583305789, 6066.272047354301, 6081.908771368433, 6113.449789518964, 4056.6551843093666, 4093.795310234536, 4103.281925662997, 4104.322786740155, 4118.382242663624, 4098.7130900836655, 4110.527289361702, 4121.670266378683, 4139.606737359946, 4143.875683729493, 4560.657950653648, 4768.833090841804, 4773.591790421834, 4801.135795556834, 4820.831270905502, 5782.971085144547, 5824.514748739044, 5827.883442331215, 5841.678707671119, 5862.589618726648, 1493.46235355272, 1498.4905132255085, 1506.49532406645, 1511.780791785185, 1516.1282262698992, 913.4930113786779, 967.6226271754022, 984.6652138273022, 991.7173605522391, 997.3218211616171, 5926.525877929756, 5938.406159384027, 5943.762249509971, 5951.137085122719, 5957.434043765836, 6239.625622462667, 6247.781327653511, 6275.843103922439, 6365.681715914186, 6404.519661025349, 5798.362180160179, 5834.27071616048, 5896.557758168155, 5905.409459054146, 5940.821775346746, 3348.648391918862, 3357.2110554019787, 3372.730181585467, 3382.797032178077, 3402.472616744359, 6390.370455533902, 6468.514861385415, 6523.151990241238, 6551.443127334134, 6577.934220657828, 6446.774362897276, 6447.6131432114225, 6448.548601597843, 6451.1936007999, 6459.483241340681, 6332.208473940757, 6497.740090396331, 6533.150690410216, 6579.374959378852, 6592.76925307612, 6273.843153921189, 6274.749010039547, 6302.369763023661, 6318.778842740482, 6327.936720632735, 6179.660118693515, 6270.0908368287255, 6282.246130464374, 6297.338779428094, 6309.012661011767, 6432.742690292524, 6477.935220647733, 6505.0, 6520.043986804035, 6550.83622909412, 4252.787360632018, 4268.381084742757, 4283.892902677333, 4290.141971605629, 4294.098239369768, 6253.874922501615, 6275.403836635513, 6323.588966717149, 6347.460465860454, 6372.840678983062, 6075.483583895419, 6128.724207410588, 6130.172426722335, 6185.350538193605, 6188.535859810442, 5947.672877991752, 6133.233345831771, 6157.84605384869, 6176.227971503562, 6200.627962322094, 5444.237806707143, 5544.251526043932, 5691.459311365414, 6010.669413182317, 6034.909476357946, 5820.476157145878, 5860.677662728591, 5871.794487192928, 5886.175935368966, 5890.352061273342, 5559.833205003856, 5721.828345149652, 5797.333306669619, 5797.710114494174, 5818.0981947798155], "value": 4489.735590089004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.121936115384, 797.1152021256404, 820.7086484298073, 823.9217274358941, 851.6976473351959, 14351.282435878204, 14638.194899280536, 14677.926610366947, 14910.105393676373, 14911.254437278147, 13566.72866542671, 13678.179309241452, 13683.24742139182, 13695.726085478285, 13750.106243094191, 836.1346006882877, 867.8394497018072, 869.6651789061194, 870.2646263906988, 872.7512658892217, 846.5978660136417, 853.2789792625252, 853.56894768142, 856.3235044315015, 858.2061593026425, 895.8790563273973, 896.8520194167954, 899.9010108888017, 902.0573500691793, 902.467544148952, 887.5650931043807, 891.7948871759467, 894.592960203106, 896.8565029595266, 901.3600343755941, 649.04590252329, 654.319507711979, 655.1188651264042, 655.632845606462, 658.6904155047168, 14619.92690036543, 14655.0, 14727.337269822883, 14751.0, 14780.743636790885, 13632.727345453135, 13783.51757688476, 14030.0, 14068.718625627533, 14095.295235238196, 11418.029467495273, 11530.365829879353, 11547.711307217303, 11559.479823407966, 11577.884221157849, 3744.6817020553285, 3783.148791521913, 3831.616838316146, 3907.179492306619, 3937.3306537888343, 56071.15893261605, 56254.71872640611, 56600.43399565993, 56670.0, 56994.43005569974, 10954.616588419527, 10968.405085523687, 11021.889781102087, 11025.724356891142, 11202.271852329572, 18887.622247554973, 19048.71426928597, 19133.330333438542, 19175.616487670446, 19453.513662158275, 8321.209485098905, 8337.95831020853, 8349.8330033399, 8418.663253469915, 8420.705275315335, 4557.635389168859, 4611.608013318905, 4635.496831710906, 4642.86071417858, 4770.95229047712, 3221.3557288542384, 3287.2110693433883, 3287.2767991041933, 3298.241404476984, 3305.652906444837, 553.9806106786324, 557.0641322578108, 564.7345747498669, 581.682982774389, 591.6538824787461, 675.1223409567542, 701.7789396340137, 775.4998026273136, 775.97672069838, 793.3930543134506, 9880.35777674449, 10070.244731645156, 10206.183505319557, 10256.897431025744, 10413.219008574388, 582.6445868020504, 634.5558109323492, 684.5755631508497, 688.3495097133161, 727.3562896836232, 4551.5676010778925, 4621.098885717252, 4669.486356500782, 4679.0, 4788.162071637449, 66785.33214667888, 67185.66407167933, 67557.0, 67558.3244167562, 67885.3211467879, 57531.0, 57715.711421442626, 58258.70870645619, 59317.40682593119, 59354.10968835471, 48263.0, 50365.0, 50705.23942140871, 51415.0, 52378.47621523812, 9117.452952822852, 9158.038405967278, 9160.267178625561, 9330.113639204264, 9433.386829856037, 34947.30105397929, 35072.64927350796, 35587.0, 35965.0, 36322.27355452929, 43956.0, 48236.75881620569, 48361.274580880614, 48826.0, 48901.5109848897, 11617.709557261136, 11705.239159454608, 11776.76446471083, 11806.0, 12129.150959432754, 12720.363981801058, 13008.414621342252, 13014.011272525084, 13027.413766380347, 13133.60599182026, 11158.44207789591, 11528.654140375802, 11538.192326537062, 11579.478923448634, 11731.120165987755, 12257.14200005991, 12424.130310878152, 12438.19151755133, 12473.0, 12547.74904501923, 12087.576934807239, 12270.263784172977, 12480.251184928933, 12487.375631218585, 12554.623361299176, 10325.74185645365, 10659.25385223027, 10726.141908647134, 10746.301490403099, 10894.782104358026, 10166.745831354276, 10651.840222396515, 10691.732706682084, 10775.0, 10822.729431764268], "value": 6834.888954385487, "unit": "score"}], "name": "dromaeo_css", "value": 7010.972298274509, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 118.0, 110.0, 116.0, 124.0, 112.0, 111.0, 113.0, 112.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 159.0, 181.0, 127.0, 158.0, 158.0, 132.0, 184.0, 137.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 161.0, 166.0, 172.0, 162.0, 165.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 77.0, 162.0, 77.0, 76.0, 77.0, 75.0, 169.0, 77.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 148.0, 92.0, 93.0, 93.0, 157.0, 92.0, 94.0, 148.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 117.0, 121.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 58.0, 58.0, 63.0, 63.0, 58.0, 73.0, 58.0, 56.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 78.0, 78.0, 79.0, 79.0, 79.0, 80.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 135.0, 127.0, 134.0, 132.0, 129.0, 141.0, 167.0, 135.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 167.0, 166.0, 172.0, 165.0, 169.0, 166.0, 176.0, 166.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 67.0, 68.0, 67.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1564.3999999999996, "alertThreshold": 2.0}]} 06:18:01 INFO - Return code: 0 06:18:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:18:01 ERROR - # TBPL SUCCESS # 06:18:01 INFO - Running post-action listener: _resource_record_post_action 06:18:01 INFO - Running post-run listener: _resource_record_post_run 06:18:02 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545685504; Read time: 8; Write time: 587988 06:18:02 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251691008; Read time: 0; Write time: 357652 06:18:02 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293994496; Read time: 8; Write time: 230336 06:18:02 INFO - Running post-run listener: _upload_blobber_files 06:18:02 INFO - Blob upload gear active. 06:18:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:02 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 06:18:02 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:02 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:02 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:18:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:18:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:03 INFO - (blobuploader) - INFO - Done attempting. 06:18:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:18:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:18:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:04 INFO - (blobuploader) - INFO - Done attempting. 06:18:04 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:04 INFO - Return code: 0 06:18:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2dda385dec42b7884b2aa82580f73675eb20ed051c37460c3d26723ef632e10a1473511e0dd3d505b0688ec4b1939c008a6b3a2a72013a52cb3b7f3e087d4d0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f1359b41efa47f3bc56057088ec9d3cb8385dd02e7e6f8c1e985fc1c5a34e87c84036b67bcb659aaddd4d9360836885537e4ce70692785603ad895e7f1f7dbf"} 06:18:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:04 INFO - Contents: 06:18:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2dda385dec42b7884b2aa82580f73675eb20ed051c37460c3d26723ef632e10a1473511e0dd3d505b0688ec4b1939c008a6b3a2a72013a52cb3b7f3e087d4d0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f1359b41efa47f3bc56057088ec9d3cb8385dd02e7e6f8c1e985fc1c5a34e87c84036b67bcb659aaddd4d9360836885537e4ce70692785603ad895e7f1f7dbf"} 06:18:04 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:04 INFO - Copying logs to upload dir... 06:18:04 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.916410 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-29 06:18:04.459108) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 06:18:04.464478) ========= 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=32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732 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/sha512/2dda385dec42b7884b2aa82580f73675eb20ed051c37460c3d26723ef632e10a1473511e0dd3d505b0688ec4b1939c008a6b3a2a72013a52cb3b7f3e087d4d0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f1359b41efa47f3bc56057088ec9d3cb8385dd02e7e6f8c1e985fc1c5a34e87c84036b67bcb659aaddd4d9360836885537e4ce70692785603ad895e7f1f7dbf"} build_url:https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/aTvdw-XeQL-m4OahLzUkGg/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/sha512/2dda385dec42b7884b2aa82580f73675eb20ed051c37460c3d26723ef632e10a1473511e0dd3d505b0688ec4b1939c008a6b3a2a72013a52cb3b7f3e087d4d0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f1359b41efa47f3bc56057088ec9d3cb8385dd02e7e6f8c1e985fc1c5a34e87c84036b67bcb659aaddd4d9360836885537e4ce70692785603ad895e7f1f7dbf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 06:18:04.489809) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 06:18:04.490150) ========= 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=32c5991c409366f7fec8a718000001d2-1461934348.620140-953043732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 06:18:04.573087) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 06:18:04.573395) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 06:18:04.573686) ========= ========= Total master_lag: 0.17 =========