builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1461338945.21 results: success (0) buildid: 20160422065716 builduid: b45713089684492fa0483343b4eeab0c revision: fc15477ce628599519cb0055f52cc195d640dc94 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:05.214836) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:05.215288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:05.216630) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:05.341631) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:05.341955) ========= 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=82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 08:29:05-- 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% 46.4M=0s 2016-04-22 08:29:06 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134317 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:05.489546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:05.489860) ========= 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=82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013707 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:05.539656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:05.540011) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fc15477ce628599519cb0055f52cc195d640dc94 --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 fc15477ce628599519cb0055f52cc195d640dc94 --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=82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 08:29:06,222 truncating revision to first 12 chars 2016-04-22 08:29:06,222 Setting DEBUG logging. 2016-04-22 08:29:06,222 attempt 1/10 2016-04-22 08:29:06,222 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fc15477ce628?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 08:29:06,549 unpacking tar archive at: mozilla-central-fc15477ce628/testing/mozharness/ program finished with exit code 0 elapsedTime=0.597814 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:06.150581) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:06.150888) ========= script_repo_revision: fc15477ce628599519cb0055f52cc195d640dc94 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:06.151318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:06.151589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 08:29:06.311911) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 08:29:06.312323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:29:07 INFO - MultiFileLogger online at 20160422 08:29:07 in /builds/slave/test 08:29:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:29:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:29:07 INFO - {'append_to_log': False, 08:29:07 INFO - 'base_work_dir': '/builds/slave/test', 08:29:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:29:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:29:07 INFO - 'branch': 'Firefox-Non-PGO', 08:29:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:29:07 INFO - 'config_files': ('talos/linux_config.py',), 08:29:07 INFO - 'default_actions': ('clobber', 08:29:07 INFO - 'read-buildbot-config', 08:29:07 INFO - 'download-and-extract', 08:29:07 INFO - 'populate-webroot', 08:29:07 INFO - 'create-virtualenv', 08:29:07 INFO - 'install', 08:29:07 INFO - 'run-tests'), 08:29:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:29:07 INFO - 'download_minidump_stackwalk': True, 08:29:07 INFO - 'download_symbols': 'ondemand', 08:29:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:29:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:29:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:29:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:29:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:29:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:29:07 INFO - 'installer_path': 'installer.exe', 08:29:07 INFO - 'log_level': 'info', 08:29:07 INFO - 'log_name': 'talos', 08:29:07 INFO - 'log_to_console': True, 08:29:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:29:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:29:07 INFO - 'opt_config_files': (), 08:29:07 INFO - 'pip_index': False, 08:29:07 INFO - 'sps_profile': False, 08:29:07 INFO - 'sps_profile_interval': 0, 08:29:07 INFO - 'suite': 'dromaeojs-e10s', 08:29:07 INFO - 'system_bits': '32', 08:29:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:29:07 INFO - 'title': 'talos-linux64-ix-055', 08:29:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:29:07 INFO - 'use_talos_json': True, 08:29:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:29:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:29:07 INFO - 'work_dir': 'build'} 08:29:07 INFO - ##### 08:29:07 INFO - ##### Running clobber step. 08:29:07 INFO - ##### 08:29:07 INFO - Running pre-action listener: _resource_record_pre_action 08:29:07 INFO - Running main action method: clobber 08:29:07 INFO - rmtree: /builds/slave/test/build 08:29:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:29:07 INFO - Running post-action listener: _resource_record_post_action 08:29:07 INFO - ##### 08:29:07 INFO - ##### Running read-buildbot-config step. 08:29:07 INFO - ##### 08:29:07 INFO - Running pre-action listener: _resource_record_pre_action 08:29:07 INFO - Running main action method: read_buildbot_config 08:29:07 INFO - Using buildbot properties: 08:29:07 INFO - { 08:29:07 INFO - "project": "", 08:29:07 INFO - "product": "firefox", 08:29:07 INFO - "script_repo_revision": "production", 08:29:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:29:07 INFO - "repository": "", 08:29:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:29:07 INFO - "buildid": "20160422065716", 08:29:07 INFO - "pgo_build": "False", 08:29:07 INFO - "basedir": "/builds/slave/test", 08:29:07 INFO - "buildnumber": 334, 08:29:07 INFO - "slavename": "talos-linux64-ix-055", 08:29:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:29:07 INFO - "platform": "ubuntu64_hw", 08:29:07 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:29:07 INFO - "branch": "mozilla-central", 08:29:07 INFO - "repo_path": "mozilla-central", 08:29:07 INFO - "revision": "fc15477ce628599519cb0055f52cc195d640dc94", 08:29:07 INFO - "stage_platform": "linux64", 08:29:07 INFO - "builduid": "b45713089684492fa0483343b4eeab0c", 08:29:07 INFO - "slavebuilddir": "test" 08:29:07 INFO - } 08:29:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:29:07 INFO - Running post-action listener: _resource_record_post_action 08:29:07 INFO - ##### 08:29:07 INFO - ##### Running download-and-extract step. 08:29:07 INFO - ##### 08:29:07 INFO - Running pre-action listener: _resource_record_pre_action 08:29:07 INFO - Running main action method: download_and_extract 08:29:07 INFO - mkdir: /builds/slave/test/build/tests 08:29: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')]} 08:29:07 INFO - https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:29:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:29:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:29:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:29:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:29:09 INFO - Downloaded 1361 bytes. 08:29:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:29:09 INFO - Using the following test package requirements: 08:29:09 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:29:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:29:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:29:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:09 INFO - u'jsshell-linux-x86_64.zip'], 08:29:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:29:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:29:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:29:09 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:29:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:29:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:29:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:29: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')]} 08:29:09 INFO - https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:29:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:29:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:29:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:29:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:29:10 INFO - Downloaded 22285370 bytes. 08:29:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:29:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:29:12 INFO - Return code: 0 08:29:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:12 INFO - https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:29:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:29:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:29:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:29:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:29:13 INFO - Downloaded 22285370 bytes. 08:29:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:29:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:29:14 INFO - Return code: 0 08:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:14 INFO - https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:29:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:29:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:29:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:29:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:29:15 INFO - Downloaded 10840145 bytes. 08:29:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:29:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:29:15 INFO - Return code: 0 08:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:15 INFO - https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:29:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:29:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:29:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:29:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:29:17 INFO - Downloaded 54660662 bytes. 08:29:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:29:17 INFO - mkdir: /builds/slave/test/properties 08:29:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:29:17 INFO - Writing to file /builds/slave/test/properties/build_url 08:29:17 INFO - Contents: 08:29:17 INFO - build_url:https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:29:18 INFO - Running post-action listener: _resource_record_post_action 08:29:18 INFO - Running post-action listener: set_extra_try_arguments 08:29:18 INFO - ##### 08:29:18 INFO - ##### Running populate-webroot step. 08:29:18 INFO - ##### 08:29:18 INFO - Running pre-action listener: _resource_record_pre_action 08:29:18 INFO - Running main action method: populate_webroot 08:29:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:29:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:29:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:29:18 INFO - '--tppagecycles', 08:29:18 INFO - '7'], 08:29:18 INFO - 'tests': ['tsvgm']}}, 08:29:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:29:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:29:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:29:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:29:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:29:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:29:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:18 INFO - 'talos_options': ['--disable-e10s'], 08:29:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:18 INFO - 'talos_options': ['--disable-e10s'], 08:29:18 INFO - 'tests': ['damp', 'tps']}, 08:29:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:18 INFO - 'tests': ['damp', 'tps']}, 08:29:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:29:18 INFO - 'tests': ['dromaeo_dom']}, 08:29:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:29:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:29:18 INFO - 'tests': ['a11yr', 08:29:18 INFO - 'ts_paint', 08:29:18 INFO - 'tpaint', 08:29:18 INFO - 'sessionrestore', 08:29:18 INFO - 'sessionrestore_no_auto_restore', 08:29:18 INFO - 'tabpaint']}, 08:29:18 INFO - 'other-e10s': {'tests': ['a11yr', 08:29:18 INFO - 'ts_paint', 08:29:18 INFO - 'tpaint', 08:29:18 INFO - 'sessionrestore', 08:29:18 INFO - 'sessionrestore_no_auto_restore', 08:29:18 INFO - 'tabpaint']}, 08:29:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:29:18 INFO - 'ts_paint', 08:29:18 INFO - 'tpaint', 08:29:18 INFO - 'sessionrestore', 08:29:18 INFO - 'sessionrestore_no_auto_restore', 08:29:18 INFO - 'tabpaint']}, 08:29:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:29:18 INFO - 'ts_paint', 08:29:18 INFO - 'tpaint', 08:29:18 INFO - 'sessionrestore', 08:29:18 INFO - 'sessionrestore_no_auto_restore', 08:29:18 INFO - 'tabpaint']}, 08:29:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:29:18 INFO - 'tests': ['a11yr', 08:29:18 INFO - 'ts_paint', 08:29:18 INFO - 'tpaint', 08:29:18 INFO - 'sessionrestore', 08:29:18 INFO - 'sessionrestore_no_auto_restore', 08:29:18 INFO - 'tabpaint']}, 08:29:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:29:18 INFO - 'tests': ['a11yr', 08:29:18 INFO - 'ts_paint', 08:29:18 INFO - 'tpaint', 08:29:18 INFO - 'sessionrestore', 08:29:18 INFO - 'sessionrestore_no_auto_restore', 08:29:18 INFO - 'tabpaint']}, 08:29:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:29:18 INFO - 'tests': ['tsvgx', 08:29:18 INFO - 'tsvgr_opacity', 08:29:18 INFO - 'tart', 08:29:18 INFO - 'tscrollx', 08:29:18 INFO - 'cart']}, 08:29:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:29:18 INFO - 'tsvgr_opacity', 08:29:18 INFO - 'tart', 08:29:18 INFO - 'tscrollx', 08:29:18 INFO - 'cart']}, 08:29:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:18 INFO - 'talos_options': ['--disable-e10s'], 08:29:18 INFO - 'tests': ['tp5o']}, 08:29:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:18 INFO - 'tests': ['tp5o']}, 08:29:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:18 INFO - 'talos_options': ['--disable-e10s', 08:29:18 INFO - '--xperf_path', 08:29:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:18 INFO - 'tests': ['tp5n']}, 08:29:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:18 INFO - 'talos_options': ['--xperf_path', 08:29:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:18 INFO - 'tests': ['tp5n']}}, 08:29:18 INFO - 'talos.zip': {'path': '', 08:29:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:29:18 INFO - Running post-action listener: _resource_record_post_action 08:29:18 INFO - ##### 08:29:18 INFO - ##### Running create-virtualenv step. 08:29:18 INFO - ##### 08:29:18 INFO - Running pre-action listener: _resource_record_pre_action 08:29:18 INFO - Running main action method: create_virtualenv 08:29:18 INFO - Creating virtualenv /builds/slave/test/build/venv 08:29:18 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 08:29:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:29:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:29:18 INFO - Using real prefix '/usr' 08:29:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:29:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:29:20 INFO - Installing pip.................done. 08:29:20 INFO - Return code: 0 08:29:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:29:20 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')]} 08:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:20 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')]} 08:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:20 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 0x7fb12597cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3410>, '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 0x19d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', '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 08:29:20 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 08:29:20 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 08:29:20 INFO - Using env: {'DISPLAY': ':0', 08:29:20 INFO - 'HOME': '/home/cltbld', 08:29:20 INFO - 'LANG': 'en_US.UTF-8', 08:29:20 INFO - 'LANGUAGE': 'en_US:en', 08:29:20 INFO - 'LOGNAME': 'cltbld', 08:29:20 INFO - 'MAIL': '/var/mail/cltbld', 08:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:20 INFO - 'MOZ_NO_REMOTE': '1', 08:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:20 INFO - 'NO_EM_RESTART': '1', 08:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:20 INFO - 'PWD': '/builds/slave/test', 08:29:20 INFO - 'SHELL': '/bin/bash', 08:29:20 INFO - 'SHLVL': '1', 08:29:20 INFO - 'TERM': 'linux', 08:29:20 INFO - 'TMOUT': '86400', 08:29:20 INFO - 'USER': 'cltbld', 08:29:20 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', 08:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:20 INFO - '_': '/tools/buildbot/bin/python'} 08:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:20 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 08:29:20 INFO - Cleaning up... 08:29:20 INFO - Return code: 0 08:29:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:29:20 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')]} 08:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:20 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')]} 08:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:20 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 0x7fb12597cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3410>, '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 0x19d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', '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 08:29:20 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 08:29:20 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 08:29:20 INFO - Using env: {'DISPLAY': ':0', 08:29:20 INFO - 'HOME': '/home/cltbld', 08:29:20 INFO - 'LANG': 'en_US.UTF-8', 08:29:20 INFO - 'LANGUAGE': 'en_US:en', 08:29:20 INFO - 'LOGNAME': 'cltbld', 08:29:20 INFO - 'MAIL': '/var/mail/cltbld', 08:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:20 INFO - 'MOZ_NO_REMOTE': '1', 08:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:20 INFO - 'NO_EM_RESTART': '1', 08:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:20 INFO - 'PWD': '/builds/slave/test', 08:29:20 INFO - 'SHELL': '/bin/bash', 08:29:20 INFO - 'SHLVL': '1', 08:29:20 INFO - 'TERM': 'linux', 08:29:20 INFO - 'TMOUT': '86400', 08:29:20 INFO - 'USER': 'cltbld', 08:29:20 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', 08:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:20 INFO - '_': '/tools/buildbot/bin/python'} 08:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:21 INFO - Downloading/unpacking psutil>=0.7.1 08:29:21 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 08:29:21 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 08:29:21 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 08:29:21 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 08:29:21 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 08:29:21 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 08:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:29:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:23 INFO - Installing collected packages: psutil 08:29:23 INFO - Running setup.py install for psutil 08:29:23 INFO - building 'psutil._psutil_linux' extension 08:29:23 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 08:29:23 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 08:29:23 INFO - building 'psutil._psutil_posix' extension 08:29:23 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 08:29:23 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 08:29:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:23 INFO - Successfully installed psutil 08:29:23 INFO - Cleaning up... 08:29:23 INFO - Return code: 0 08:29:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:23 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 0x7fb12597cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3410>, '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 0x19d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', '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 08:29:23 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 08:29:23 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 08:29:23 INFO - Using env: {'DISPLAY': ':0', 08:29:23 INFO - 'HOME': '/home/cltbld', 08:29:23 INFO - 'LANG': 'en_US.UTF-8', 08:29:23 INFO - 'LANGUAGE': 'en_US:en', 08:29:23 INFO - 'LOGNAME': 'cltbld', 08:29:23 INFO - 'MAIL': '/var/mail/cltbld', 08:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:23 INFO - 'MOZ_NO_REMOTE': '1', 08:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:23 INFO - 'NO_EM_RESTART': '1', 08:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:23 INFO - 'PWD': '/builds/slave/test', 08:29:23 INFO - 'SHELL': '/bin/bash', 08:29:23 INFO - 'SHLVL': '1', 08:29:23 INFO - 'TERM': 'linux', 08:29:23 INFO - 'TMOUT': '86400', 08:29:23 INFO - 'USER': 'cltbld', 08:29:23 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', 08:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:23 INFO - '_': '/tools/buildbot/bin/python'} 08:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:29:23 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 08:29:23 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 08:29:23 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 08:29:23 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 08:29:23 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 08:29:23 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 08:29:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:29:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:29:25 INFO - Installing collected packages: mozsystemmonitor 08:29:25 INFO - Running setup.py install for mozsystemmonitor 08:29:25 INFO - Successfully installed mozsystemmonitor 08:29:25 INFO - Cleaning up... 08:29:25 INFO - Return code: 0 08:29:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:29:25 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')]} 08:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:25 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')]} 08:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:26 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 0x7fb12597cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3410>, '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 0x19d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', '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 08:29:26 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 08:29:26 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 08:29:26 INFO - Using env: {'DISPLAY': ':0', 08:29:26 INFO - 'HOME': '/home/cltbld', 08:29:26 INFO - 'LANG': 'en_US.UTF-8', 08:29:26 INFO - 'LANGUAGE': 'en_US:en', 08:29:26 INFO - 'LOGNAME': 'cltbld', 08:29:26 INFO - 'MAIL': '/var/mail/cltbld', 08:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:26 INFO - 'MOZ_NO_REMOTE': '1', 08:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:26 INFO - 'NO_EM_RESTART': '1', 08:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:26 INFO - 'PWD': '/builds/slave/test', 08:29:26 INFO - 'SHELL': '/bin/bash', 08:29:26 INFO - 'SHLVL': '1', 08:29:26 INFO - 'TERM': 'linux', 08:29:26 INFO - 'TMOUT': '86400', 08:29:26 INFO - 'USER': 'cltbld', 08:29:26 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', 08:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:26 INFO - '_': '/tools/buildbot/bin/python'} 08:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:29:26 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 08:29:26 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 08:29:26 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 08:29:26 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 08:29:26 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 08:29:26 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 08:29:28 INFO - Downloading blobuploader-1.2.4.tar.gz 08:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:29:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:29:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:28 INFO - Downloading docopt-0.6.1.tar.gz 08:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:29:29 INFO - Installing collected packages: blobuploader, requests, docopt 08:29:29 INFO - Running setup.py install for blobuploader 08:29:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:29:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:29:29 INFO - Running setup.py install for requests 08:29:29 INFO - Running setup.py install for docopt 08:29:29 INFO - Successfully installed blobuploader requests docopt 08:29:29 INFO - Cleaning up... 08:29:29 INFO - Return code: 0 08:29:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:29 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 0x7fb12597cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3410>, '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 0x19d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', '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 08:29:29 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 08:29:29 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 08:29:29 INFO - Using env: {'DISPLAY': ':0', 08:29:29 INFO - 'HOME': '/home/cltbld', 08:29:29 INFO - 'LANG': 'en_US.UTF-8', 08:29:29 INFO - 'LANGUAGE': 'en_US:en', 08:29:29 INFO - 'LOGNAME': 'cltbld', 08:29:29 INFO - 'MAIL': '/var/mail/cltbld', 08:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:29 INFO - 'MOZ_NO_REMOTE': '1', 08:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:29 INFO - 'NO_EM_RESTART': '1', 08:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:29 INFO - 'PWD': '/builds/slave/test', 08:29:29 INFO - 'SHELL': '/bin/bash', 08:29:29 INFO - 'SHLVL': '1', 08:29:29 INFO - 'TERM': 'linux', 08:29:29 INFO - 'TMOUT': '86400', 08:29:29 INFO - 'USER': 'cltbld', 08:29:29 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', 08:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:29 INFO - '_': '/tools/buildbot/bin/python'} 08:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:29 INFO - Running setup.py (path:/tmp/pip-AOTP9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:29 INFO - Running setup.py (path:/tmp/pip-3fmRTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:29 INFO - Running setup.py (path:/tmp/pip-8XhQbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:30 INFO - Running setup.py (path:/tmp/pip-Kk390y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:30 INFO - Running setup.py (path:/tmp/pip-wV2Z4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:30 INFO - Running setup.py (path:/tmp/pip-m72aCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:30 INFO - Running setup.py (path:/tmp/pip-0a5D2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:30 INFO - Running setup.py (path:/tmp/pip-IeGvzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:30 INFO - Running setup.py (path:/tmp/pip-xdsgeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:30 INFO - Running setup.py (path:/tmp/pip-rtL4zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:30 INFO - Running setup.py (path:/tmp/pip-S5W6dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:30 INFO - Running setup.py (path:/tmp/pip-kg7YiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:30 INFO - Running setup.py (path:/tmp/pip-QA_uQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:30 INFO - Running setup.py (path:/tmp/pip-N4wdWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:30 INFO - Running setup.py (path:/tmp/pip-vkGY1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:30 INFO - Running setup.py (path:/tmp/pip-gLouqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:30 INFO - Running setup.py (path:/tmp/pip-8QQ_O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:29:31 INFO - Running setup.py install for manifestparser 08:29:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:29:31 INFO - Running setup.py install for mozcrash 08:29:31 INFO - Running setup.py install for mozdebug 08:29:31 INFO - Running setup.py install for mozdevice 08:29:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:29:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:29:31 INFO - Running setup.py install for mozfile 08:29:31 INFO - Running setup.py install for mozhttpd 08:29:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:29:31 INFO - Running setup.py install for mozinfo 08:29:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:29:31 INFO - Running setup.py install for mozInstall 08:29:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:29:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:29:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:29:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:29:31 INFO - Running setup.py install for mozleak 08:29:31 INFO - Running setup.py install for mozlog 08:29:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:29:32 INFO - Running setup.py install for moznetwork 08:29:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:29:32 INFO - Running setup.py install for mozprocess 08:29:32 INFO - Running setup.py install for mozprofile 08:29:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:29:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:29:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:29:32 INFO - Running setup.py install for mozrunner 08:29:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:29:32 INFO - Running setup.py install for mozscreenshot 08:29:32 INFO - Running setup.py install for moztest 08:29:32 INFO - Running setup.py install for mozversion 08:29:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:29:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:29:32 INFO - Cleaning up... 08:29:32 INFO - Return code: 0 08:29:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:32 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 0x7fb12597cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3410>, '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 0x19d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', '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 08:29:32 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 08:29:32 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 08:29:32 INFO - Using env: {'DISPLAY': ':0', 08:29:32 INFO - 'HOME': '/home/cltbld', 08:29:32 INFO - 'LANG': 'en_US.UTF-8', 08:29:32 INFO - 'LANGUAGE': 'en_US:en', 08:29:32 INFO - 'LOGNAME': 'cltbld', 08:29:32 INFO - 'MAIL': '/var/mail/cltbld', 08:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:32 INFO - 'MOZ_NO_REMOTE': '1', 08:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:32 INFO - 'NO_EM_RESTART': '1', 08:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:32 INFO - 'PWD': '/builds/slave/test', 08:29:32 INFO - 'SHELL': '/bin/bash', 08:29:32 INFO - 'SHLVL': '1', 08:29:32 INFO - 'TERM': 'linux', 08:29:32 INFO - 'TMOUT': '86400', 08:29:32 INFO - 'USER': 'cltbld', 08:29:32 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', 08:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:32 INFO - '_': '/tools/buildbot/bin/python'} 08:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:33 INFO - Running setup.py (path:/tmp/pip-hoO7Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:33 INFO - Running setup.py (path:/tmp/pip-8Kw9GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:33 INFO - Running setup.py (path:/tmp/pip-aMOpfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:33 INFO - Running setup.py (path:/tmp/pip-DbbhFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:33 INFO - Running setup.py (path:/tmp/pip-vvNhXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:33 INFO - Running setup.py (path:/tmp/pip-uU1Kab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:33 INFO - Running setup.py (path:/tmp/pip-7Y3NFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:33 INFO - Running setup.py (path:/tmp/pip-gWCUXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:33 INFO - Running setup.py (path:/tmp/pip-LcgMlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:33 INFO - Running setup.py (path:/tmp/pip-C1k1W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:33 INFO - Running setup.py (path:/tmp/pip-qxQBy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:33 INFO - Running setup.py (path:/tmp/pip-R7hPeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:33 INFO - Running setup.py (path:/tmp/pip-USwUP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:33 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)) 08:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:33 INFO - Running setup.py (path:/tmp/pip-YadZOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:34 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)) 08:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:34 INFO - Running setup.py (path:/tmp/pip-A3KaF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:34 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)) 08:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:34 INFO - Running setup.py (path:/tmp/pip-K2LYGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:34 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)) 08:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:34 INFO - Running setup.py (path:/tmp/pip-YSrc3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:34 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)) 08:29:34 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)) 08:29:34 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)) 08:29:34 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)) 08:29:34 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)) 08:29:34 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)) 08:29:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:29:34 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 08:29:34 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 08:29:34 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 08:29:34 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 08:29:34 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 08:29:34 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 08:29:36 INFO - Downloading blessings-1.6.tar.gz 08:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:29:36 INFO - Installing collected packages: blessings 08:29:36 INFO - Running setup.py install for blessings 08:29:36 INFO - Successfully installed blessings 08:29:36 INFO - Cleaning up... 08:29:36 INFO - Return code: 0 08:29:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:29:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:36 INFO - Reading from file tmpfile_stdout 08:29:36 INFO - Current package versions: 08:29:36 INFO - argparse == 1.2.1 08:29:36 INFO - blessings == 1.6 08:29:36 INFO - blobuploader == 1.2.4 08:29:36 INFO - docopt == 0.6.1 08:29:36 INFO - manifestparser == 1.1 08:29:36 INFO - mozInstall == 1.12 08:29:36 INFO - mozcrash == 0.17 08:29:36 INFO - mozdebug == 0.1 08:29:36 INFO - mozdevice == 0.48 08:29:36 INFO - mozfile == 1.2 08:29:36 INFO - mozhttpd == 0.7 08:29:36 INFO - mozinfo == 0.9 08:29:36 INFO - mozleak == 0.1 08:29:36 INFO - mozlog == 3.1 08:29:36 INFO - moznetwork == 0.27 08:29:36 INFO - mozprocess == 0.22 08:29:36 INFO - mozprofile == 0.28 08:29:36 INFO - mozrunner == 6.11 08:29:36 INFO - mozscreenshot == 0.1 08:29:36 INFO - mozsystemmonitor == 0.0 08:29:36 INFO - moztest == 0.7 08:29:36 INFO - mozversion == 1.4 08:29:36 INFO - psutil == 3.1.1 08:29:36 INFO - requests == 1.2.3 08:29:36 INFO - wsgiref == 0.1.2 08:29:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:36 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 0x7fb12597cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3410>, '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 0x19d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', '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 08:29:36 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 08:29:36 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 08:29:36 INFO - Using env: {'DISPLAY': ':0', 08:29:36 INFO - 'HOME': '/home/cltbld', 08:29:36 INFO - 'LANG': 'en_US.UTF-8', 08:29:36 INFO - 'LANGUAGE': 'en_US:en', 08:29:36 INFO - 'LOGNAME': 'cltbld', 08:29:36 INFO - 'MAIL': '/var/mail/cltbld', 08:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:36 INFO - 'MOZ_NO_REMOTE': '1', 08:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:36 INFO - 'NO_EM_RESTART': '1', 08:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:36 INFO - 'PWD': '/builds/slave/test', 08:29:36 INFO - 'SHELL': '/bin/bash', 08:29:36 INFO - 'SHLVL': '1', 08:29:36 INFO - 'TERM': 'linux', 08:29:36 INFO - 'TMOUT': '86400', 08:29:36 INFO - 'USER': 'cltbld', 08:29:36 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', 08:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:36 INFO - '_': '/tools/buildbot/bin/python'} 08:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:37 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)) 08:29:37 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)) 08:29:37 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)) 08:29:37 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)) 08:29:37 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)) 08:29:37 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)) 08:29:37 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)) 08:29:37 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)) 08:29:37 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)) 08:29:37 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)) 08:29:37 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)) 08:29:37 INFO - Cleaning up... 08:29:37 INFO - Return code: 0 08:29:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:29:37 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')]} 08:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:37 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')]} 08:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:37 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 0x7fb12597cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3410>, '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 0x19d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', '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 08:29:37 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 08:29:37 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 08:29:37 INFO - Using env: {'DISPLAY': ':0', 08:29:37 INFO - 'HOME': '/home/cltbld', 08:29:37 INFO - 'LANG': 'en_US.UTF-8', 08:29:37 INFO - 'LANGUAGE': 'en_US:en', 08:29:37 INFO - 'LOGNAME': 'cltbld', 08:29:37 INFO - 'MAIL': '/var/mail/cltbld', 08:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:37 INFO - 'MOZ_NO_REMOTE': '1', 08:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:37 INFO - 'NO_EM_RESTART': '1', 08:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:37 INFO - 'PWD': '/builds/slave/test', 08:29:37 INFO - 'SHELL': '/bin/bash', 08:29:37 INFO - 'SHLVL': '1', 08:29:37 INFO - 'TERM': 'linux', 08:29:37 INFO - 'TMOUT': '86400', 08:29:37 INFO - 'USER': 'cltbld', 08:29:37 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', 08:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:37 INFO - '_': '/tools/buildbot/bin/python'} 08:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:37 INFO - Downloading/unpacking jsonschema 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:29:39 INFO - Downloading/unpacking functools32 (from jsonschema) 08:29:39 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 08:29:39 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 08:29:39 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 08:29:39 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 08:29:39 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 08:29:39 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 08:29:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:29:40 INFO - warning: no files found matching '*.txt' 08:29:40 INFO - no previously-included directories found matching 'build' 08:29:40 INFO - no previously-included directories found matching 'dist' 08:29:40 INFO - no previously-included directories found matching '.git*' 08:29:40 INFO - Installing collected packages: jsonschema, functools32 08:29:40 INFO - Running setup.py install for functools32 08:29:40 INFO - warning: no files found matching '*.txt' 08:29:40 INFO - no previously-included directories found matching 'build' 08:29:40 INFO - no previously-included directories found matching 'dist' 08:29:40 INFO - no previously-included directories found matching '.git*' 08:29:40 INFO - Successfully installed jsonschema functools32 08:29:40 INFO - Cleaning up... 08:29:40 INFO - Return code: 0 08:29:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:40 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 0x7fb12597cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d3410>, '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 0x19d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', '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 08:29:40 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 08:29:40 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 08:29:40 INFO - Using env: {'DISPLAY': ':0', 08:29:40 INFO - 'HOME': '/home/cltbld', 08:29:40 INFO - 'LANG': 'en_US.UTF-8', 08:29:40 INFO - 'LANGUAGE': 'en_US:en', 08:29:40 INFO - 'LOGNAME': 'cltbld', 08:29:40 INFO - 'MAIL': '/var/mail/cltbld', 08:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:40 INFO - 'MOZ_NO_REMOTE': '1', 08:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:40 INFO - 'NO_EM_RESTART': '1', 08:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:40 INFO - 'PWD': '/builds/slave/test', 08:29:40 INFO - 'SHELL': '/bin/bash', 08:29:40 INFO - 'SHLVL': '1', 08:29:40 INFO - 'TERM': 'linux', 08:29:40 INFO - 'TMOUT': '86400', 08:29:40 INFO - 'USER': 'cltbld', 08:29:40 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', 08:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:40 INFO - '_': '/tools/buildbot/bin/python'} 08:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:40 INFO - Downloading/unpacking flake8 08:29:40 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 08:29:40 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 08:29:40 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 08:29:40 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 08:29:40 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 08:29:40 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 08:29:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:29:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:29:42 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 08:29:42 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 08:29:42 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 08:29:42 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 08:29:42 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 08:29:42 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 08:29:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:29:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:29:43 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 08:29:43 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 08:29:43 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 08:29:43 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 08:29:43 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 08:29:43 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 08:29:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:29:43 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 08:29:43 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 08:29:43 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 08:29:43 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 08:29:43 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 08:29:43 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 08:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:29:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:29:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:29:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:29:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:29:43 INFO - no previously-included directories found matching 'docs/_build' 08:29:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:29:43 INFO - Running setup.py install for pep8 08:29:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:29:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:29:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:29:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:29:43 INFO - no previously-included directories found matching 'docs/_build' 08:29:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:29:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:29:43 INFO - Cleaning up... 08:29:43 INFO - Return code: 0 08:29:43 INFO - Running post-action listener: _resource_record_post_action 08:29:43 INFO - Running post-action listener: _start_resource_monitoring 08:29:43 INFO - Starting resource monitoring. 08:29:43 INFO - ##### 08:29:43 INFO - ##### Running install step. 08:29:43 INFO - ##### 08:29:43 INFO - Running pre-action listener: _resource_record_pre_action 08:29:43 INFO - Running main action method: install 08:29:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:44 INFO - Reading from file tmpfile_stdout 08:29:44 INFO - Detecting whether we're running mozinstall >=1.0... 08:29:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:29:44 INFO - Reading from file tmpfile_stdout 08:29:44 INFO - Output received: 08:29:44 INFO - Usage: mozinstall [options] installer 08:29:44 INFO - Options: 08:29:44 INFO - -h, --help show this help message and exit 08:29:44 INFO - -d DEST, --destination=DEST 08:29:44 INFO - Directory to install application into. [default: 08:29:44 INFO - "/builds/slave/test"] 08:29:44 INFO - --app=APP Application being installed. [default: firefox] 08:29:44 INFO - mkdir: /builds/slave/test/build/application 08:29:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:29:59 INFO - Reading from file tmpfile_stdout 08:29:59 INFO - Output received: 08:29:59 INFO - /builds/slave/test/build/application/firefox/firefox 08:29:59 INFO - Running post-action listener: _resource_record_post_action 08:29:59 INFO - ##### 08:29:59 INFO - ##### Running run-tests step. 08:29:59 INFO - ##### 08:29:59 INFO - Running pre-action listener: _resource_record_pre_action 08:29:59 INFO - Running main action method: run_tests 08:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:29:59 INFO - Python 2.7.3 08:29:59 INFO - Return code: 0 08:29:59 INFO - grabbing minidump binary from tooltool 08:29: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')]} 08:29:59 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 0x19d3410>, '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 0x19d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:29:59 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 08:29:59 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 08:30:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:30:00 INFO - Return code: 0 08:30:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:30:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:30:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:30:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:30:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:30:00 INFO - Return code: 0 08:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 08:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 08:30:00 INFO - Using env: {'DISPLAY': ':0', 08:30:00 INFO - 'HOME': '/home/cltbld', 08:30:00 INFO - 'LANG': 'en_US.UTF-8', 08:30:00 INFO - 'LANGUAGE': 'en_US:en', 08:30:00 INFO - 'LOGNAME': 'cltbld', 08:30:00 INFO - 'MAIL': '/var/mail/cltbld', 08:30:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:30:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:00 INFO - 'MOZ_NO_REMOTE': '1', 08:30:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:00 INFO - 'NO_EM_RESTART': '1', 08:30:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:00 INFO - 'PWD': '/builds/slave/test', 08:30:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:30:00 INFO - 'SHELL': '/bin/bash', 08:30:00 INFO - 'SHLVL': '1', 08:30:00 INFO - 'TERM': 'linux', 08:30:00 INFO - 'TMOUT': '86400', 08:30:00 INFO - 'USER': 'cltbld', 08:30:00 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089', 08:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:00 INFO - '_': '/tools/buildbot/bin/python'} 08:30:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 08:30:01 INFO - mozversion application_buildid: 20160422065716 08:30:01 INFO - mozversion application_changeset: fc15477ce628599519cb0055f52cc195d640dc94 08:30:01 INFO - mozversion application_display_name: Nightly 08:30:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:30:01 INFO - mozversion application_name: Firefox 08:30:01 INFO - mozversion application_remotingname: firefox 08:30:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:30:01 INFO - mozversion application_vendor: Mozilla 08:30:01 INFO - mozversion application_version: 48.0a1 08:30:01 INFO - mozversion platform_buildid: 20160422065716 08:30:01 INFO - mozversion platform_changeset: fc15477ce628599519cb0055f52cc195d640dc94 08:30:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:30:01 INFO - mozversion platform_version: 48.0a1 08:30:01 INFO - using testdate: 1461339001 08:30:01 INFO - actual date: 1461339001 08:30:01 INFO - starting webserver on 'localhost:34686' 08:30:01 INFO - SUITE-START | Running 2 tests 08:30:01 INFO - TEST-START | dromaeo_css 08:30:01 INFO - operating with platform_type : linux_ 08:30:01 INFO - Initialising browser for dromaeo_css test... 08:30:01 INFO - TEST-INFO | started process 28703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtasSe/profile http://localhost:34686/getInfo.html) 08:30:04 INFO - PROCESS | 28703 | 08:30:04 INFO - PROCESS | 28703 | (process:28770): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:30:05 INFO - PROCESS | 28703 | __metrics Screen width/height:1600/1200 08:30:05 INFO - PROCESS | 28703 | colorDepth:24 08:30:05 INFO - PROCESS | 28703 | Browser inner width/height: 1024/697 08:30:05 INFO - PROCESS | 28703 | __metrics 08:30:06 ERROR - PROCESS | 28703 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:30:07 INFO - TEST-INFO | 28703: exit 0 08:30:07 INFO - Browser initialized. 08:30:07 INFO - Running cycle 1/1 for dromaeo_css test... 08:30:07 INFO - TEST-INFO | started process 28821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtasSe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:09 INFO - PROCESS | 28821 | 08:30:09 INFO - PROCESS | 28821 | (process:28881): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:30:19 INFO - PROCESS | 28821 | RSS: Main: 165883904 08:30:19 INFO - PROCESS | 28821 | 08:31:08 INFO - PROCESS | 28821 | 1461339068855 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] 08:33:20 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:34686/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34686/tests/dromaeo/cssquery-ext.html) 08:33:21 INFO - PROCESS | 28821 | RSS: Main: 170401792 08:33:21 INFO - PROCESS | 28821 | 08:36:24 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:34686/tests/dromaeo/cssquery-ext.html (next: http://localhost:34686/tests/dromaeo/cssquery-jquery.html) 08:36:24 INFO - PROCESS | 28821 | RSS: Main: 166694912 08:36:24 INFO - PROCESS | 28821 | 08:39:26 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:34686/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34686/tests/dromaeo/cssquery-mootools.html) 08:39:27 INFO - PROCESS | 28821 | RSS: Main: 168140800 08:39:27 INFO - PROCESS | 28821 | 08:42:29 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:34686/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34686/tests/dromaeo/cssquery-prototype.html) 08:42:29 INFO - PROCESS | 28821 | RSS: Main: 165900288 08:42:29 INFO - PROCESS | 28821 | 08:45:32 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:34686/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34686/tests/dromaeo/cssquery-yui.html) 08:45:32 INFO - PROCESS | 28821 | RSS: Main: 167067648 08:45:32 INFO - PROCESS | 28821 | 08:48:35 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:34686/tests/dromaeo/cssquery-yui.html (next: http://localhost:34686/tests/dromaeo/cssquery-dojo.html) 08:48:35 INFO - PROCESS | 28821 | RSS: Main: 169218048 08:48:35 INFO - PROCESS | 28821 | 08:48:35 INFO - PROCESS | 28821 | __start_tp_report 08:48:35 INFO - PROCESS | 28821 | _x_x_mozilla_page_load 08:48:35 INFO - PROCESS | 28821 | _x_x_mozilla_page_load_details 08:48:35 INFO - PROCESS | 28821 | |i|pagename|runs| 08:48:35 INFO - PROCESS | 28821 | |0;dojo.html;2623.449075694104;2701.311165652759;2723.986380068099;2736.767374773144;2738.9178324650265;4733.8106475741015;4772.717109937442;4780.928286075712;4784.497627749089;4816.060868130716;4638.3970083889135;4797.592204662608;4799.256115302125;4876.268559716044;4885.364902562662;4420.469543654766;4446.288593824988;4490.483594386638;4495.707778994371;4530.22986092365;4432.135733531963;4488.214562451574;4511.436070491189;4529.841455549056;4530.252508336121;4357.651387888961;4440.822367105328;4461.754603496806;4486.035502367007;4511.413516242867;4393.450818647669;4429.15845989261;4445.8221671133115;4451.310046942729;4489.573490518395;4380.7152535085115;4385.561443855589;4391.099824535962;4399.912001759979;4438.045820148651;4684.812607495696;4739.312799644033;4773.618110551182;4785.258284965836;4812.903741925142;5165.225216217597;5175.689458632456;5186.559142472895;5188.507091826308;5217.217417387385;5096.694198348111;5155.9688062387295;5175.637705360627;5176.482351764831;5181.896362072737;4832.661713680044;4895.143349913751;4907.263910413467;4932.21084626458;4934.506549345073;5307.416184219733;5337.946620533823;5346.893062138735;5347.652402593819;5409.134538473904;4961.677490963076;5060.797568097309;5099.796008159707;5113.1052065888325;5115.846524604268;5106.744662766847;5123.513266239701;5129.743512824344;5140.7943682253035;5179.896402071938;5044.470330615306;5091.643584949018;5170.482951704799;5197.116490196676;5207.739613019334;4985.90028199434;5158.97420512895;5203.401608815035;5206.505381988705;5208.479152084761;4331.242032644274;4334.609885110355;4337.4795024596615;4365.607095361433;4372.453443319585;3760.567534733486;3797.468354430382;3813.332666783357;3816.580176180618;3833.5974722654278;4307.030918043415;4421.38100665907;4456.509783923766;4460.531644177379;4480.507144214133;5157.174852023733;5192.402873669501;5195.506426889439;5197.948020519746;5243.842684719464;4391.099824535962;4422.115576884636;4424.269995450714;4470.642348612103;4474.619657329098;4551.863444096616;4654.325122857167;4656.557627025427;4679.9532004680195;4725.031368569435;4681.227597446519;4700.059988002482;4728.361671174416;4768.451628062817;4785.95214047862;4972.204447288416;5008.899822003466;5030.496950304941;5052.570531504716;5090.160123579568;4728.243481043017;4779.30700048498;4826.58973987201;4850.927236091391;4875.853724388274;5062.31658726082;5081.745912704276;5092.694438333712;5115.104856650146;5150.0472412603785;5147.253648221062;5152.690838549699;5160.174372100446;5160.922586161286;5185.533302002837;4887.144749668865;4909.68087074339;5002.699838009731;5122.743862806919;5136.409312928911;5013.548780609763;5037.949620503748;5069.442361340323;5074.213496907985;5093.363329583802;4894.9021019578695;4905.950940490549;4927.556519913225;4932.1122198004705;4963.8262660806695;4914.99242655262;4947.431045429822;5041;5158.922616160836;5179.922301165561;4956.727379994135;4960.107180707363;5007.7496125192865;5013.373328333958;5069.493050694901 08:48:35 INFO - PROCESS | 28821 | |1;ext.html;576.3026737647447;602.6866029664575;612.3723183736666;621.7637297826825;639.4468784501402;33827.98516044516;34817.82591087047;34894.476582851275;35002.824985875064;35108.82445587775;39248.80375598118;39949;39949.400758988566;40103.19793604126;40110.7994460028;7653.464257501977;7719.305262526372;7792.532448053135;7820.41346898982;7831.765047048598;7658.2724641159275;7744.380449564022;7749.418793590475;7749.883751743729;7762.146163921964;7749.496282741632;7808.804779880492;7813.02337207849;7823.491473054261;7825.882611760828;7672.616369181575;7722.304992550669;7743.148253692089;7762.961185194038;7786.688532458723;7660.310572048543;7726.613669316512;7759.7672069838;7767.456278060538;7776.183500732454;28826.711732882613;36315.27369452596;36739.4489082664;36751.81624091889;36838;3062.8621712023014;3187.2669286064333;3235.805851648885;3278.8032718036993;3475.461303497962;27314.45371092567;27474;27549.31126721828;27586.310342241402;27786.16641500758;3223.758218133626;3231.74146068314;3241.546183534307;3303.4053870303337;3344.1973926257765;242633;250322;250492;250540;251262;33816;57964.78316951494;58699.41300587025;58720;58782.4121758777;33861.49207761885;34319.828400857834;34619.82690086534;34753.82623086868;34815.4777678335;12593.307368094842;12723.109382343147;12829.422675979604;12840.422181001877;12855.16441431304;10373.222008349405;10395.376277423378;10409;10529;10574.682759517227;8386.706465273686;8431.662733490715;8446.704365347183;8470.534120623302;8507.489550626859;3319.618243901982;3353.832308384571;3356.0901549694822;3372.3086767212662;3378.831058447068;920.2270093121809;920.9401388909699;950.4154944709093;957.0423024611039;1086.7283179205199;27458.313542161206;28678;28727.2818179543;28850.42299154005;29186.708132918822;992.245893121233;997.6531682228933;1030.0677886512717;1041.5417216424748;1060.2790102730064;14684.779728304084;15216.56534954402;15297.311620977083;15450.0729956203;15518.767218491732;354519;358682;361678;363397.18301408325;364387;49800.750996245515;50385.244221335975;50456.49543504518;50703.74648126736;50834.491655083715;1130.6325444230492;1189.7858385490695;1238.349866320171;1243.8631750507436;1255.1151438236022;26804.865975669996;27587.724122758515;27840;28493.287667808472;28509.28726781764;42401;42429.787851060544;42529.57470425256;42710.78644606757;42756.5724342765;248363;248779;249187;249839;249976;25886.741132589188;26358.472830542898;26387.472250555264;39218.607813921495;40545.59454405536;37511.43732843955;37538.55999360033;38487.807560962014;40307.1938561233;41372.379414308205;34778.652213477544;35400.64599354076;35411;35710.64289357177;35964.100897476725;34112.48831267483;34566;35040.64959350476;35209.119772005906;35488.11279718028;30207;34510.309793803484;34890.12774680552;38984;39614.40578391269;30546.31995240283;31561.21096972594;32015.199620009687;32117.518237226926;32196.35607287794;24990.37524061913;25073.623895641216;25150;25288;25370.746292536838 08:48:35 INFO - PROCESS | 28821 | |2;jquery.html;379.9905002374942;388.2855545795736;389.35251938266754;392.90766669832584;404.346979627901;12873.420696068675;15550.300236489356;15687.45093921713;16299.429519966803;16317.265723042461;16050.43823466179;16202.108884011375;16243.431479898176;16806.663866722687;17156;4944.7774850131655;5053.9241911371355;5141.30592370029;5156.20078887773;5170.793168273283;5287.206918962167;5292.947070529284;5327.041132596131;5328.813491527797;5333.546648534879;5197.688138711689;5300.310959575269;5500.614956953015;5506.421825708303;5510.779568817243;5441.537469315113;5450.972745136289;5451.972740136293;5453.209284653703;5491.725413729318;5090.54185123337;5379.273798037254;5406.08096623575;5408.567314614821;5418.674879507243;11493.195476316661;12176.330301833395;12406.937965310206;12698.492060317576;12702.491900323976;1876.7747870255657;1931.1033449825263;1961.1076959983316;2080.8751474911555;2505.023041014006;8733.388662793606;8794.648214071429;9258.490783006931;9467.905320946771;9777.951110244474;1753.5353131420184;1761.4979730776668;1783.7056885613858;1822.261983896524;1824.270291883244;65004.34995650077;65731.67134164298;66281.66859165674;67469.66265168643;67593;10199.337043092175;10221.488925553842;10269.383836969806;10332.690019299433;10447.738806529898;12719.745605087846;13589.59231223045;14361.784573231409;14381.6404589884;14448.133112013313;6837.589744615339;6847.623380714009;6900.654967251618;6909.30906909305;7026.051483049825;6052.485538729169;6136.325004249529;6148.538859585549;6177.289611694623;6293.779717709858;4323.01711818844;4411.691181617256;4421.5578442156175;4424.247877860771;4472.843450479218;1859.0983373064053;1884.6419180355688;1899.7435346228083;1907.5898681783483;1913.3112079651314;838.1995194589152;841.9705310314232;886.2555453419159;940.6002448959165;944.4333399959969;16495.670086598202;16527.33890644361;16731.414400496167;16787.54617098589;17301.56746081358;873.4279047223952;883.8453270677734;942.1708896171325;944.1172503709054;954.5179684259543;7978.880316795253;9316.813663726687;9798.706038818847;10008.399496030115;10032.598696052077;394984;410786;412951;414014;414033;77969.61015194887;78194.6090269545;78590.60704696554;78814.60592697;80370.59814701007;927.1840780113591;947.1996163242187;962.8796400449944;970.6263088710897;973.2603221551672;15800.288986995844;15991.840081599501;16072.35710571564;16094.919525402298;16274.430394936595;26677.46645067049;34330.65669343275;35734.46398303976;35862;36294.27411451809;43629.78185109181;45386.77306613446;46424.76787616176;46925;47255;7662.387009039375;7689.692412303445;7699.307062364414;7769.7669069928;7886.171951944963;10440.582376704846;11500.82748758786;11579;11822.940885295518;11942.402879856147;10240.385576865114;10346.37921724699;10374.533146008296;10441.269111162146;10476.947615261875;10204.336718113298;10309.07218350352;10349.896501034893;10470.581176752845;10474.842877356998;9794.804103918024;10072.345297555636;10263.794724105626;10354.896451035393;10892.509837057192;7936.801579960547;8013;8026.43814932949;8027.518348899085;8129;8028.759137225892;9524.190443812076;10551.103156231806;10568.735781605214;10701.250912436055 08:48:35 INFO - PROCESS | 28821 | |3;mootools.html;1418.07824913806;1474.51341057451;1561.836007219242;1741.6342568060707;1756.8770186086963;6850.3492168244065;7505;7529.134149572801;7763.456558040946;7764;7548.660310286036;7578.204288549706;7612.086549614054;7619.771406857803;7661.808454788633;2224.377174391173;2244.136007637055;2244.685743995834;2257.683924250606;2259.9887000564972;2204.9448763780874;2257.0407576779885;2260.42359198405;2269.171752310403;2282.7032485776826;2230.486987992763;2241.607718649238;2250.696156018941;2254.842161048727;2281.9657705134355;2183.1049269799387;2183.4323076000355;2192.48476607997;2198.4723666320047;2199.2632468123197;2172.055156007142;2186.8250539956766;2198.8240940724863;2203.22886989554;2214.247155966979;7646.770596882103;7691.153973062958;7705.8844117338285;7735.303822655932;7754.844903101963;4456.376107344942;4579.404677391918;4586.885327866797;4591.471980722226;4600.539946005406;2808.3540785619216;2910.359720861407;2913.970860291391;2922.7807914406294;2933.7212964768314;899.820035992804;903.0608167505786;910.5219759626183;915.8580420034905;938.9812203755887;10442.582296708122;10503.684889453329;10529.420881851494;10563.154947604173;10566.101881340095;4202.957970420318;4315.654747620183;4389.275769497997;4432.84485043022;4436.64506839452;9002.189802917768;9038.367314287936;9062.410943288665;9069.954650226839;9108.362414630912;4595.770211489412;4611.239145541015;4619.8845028873875;4630.6063984561015;4630.629549636021;3702.074481379655;4154.189932963043;4235.449391579075;4246.341817018367;4246.617804397619;3564.875229367012;3610.205754733954;3629.1471504196493;3679;3728.3475391806323;1235.4749231576543;1240.6154092231436;1253.5361916091106;1265.6835791052238;1268.2390565660714;758.4652819762055;796.625585974591;833.4582521361164;884.6461415433878;894.6600291889171;5320.733963301819;5344.305240318811;5434.2935418395355;5441.075017246998;5486.259354987025;886.9733907982771;892.9285657147412;915.0254978447931;930.4463844012802;935.6771913689767;3699.574548926854;3812.066043819282;3820.9235815284096;3857.0550215197454;3889.6110388961442;9229.907700922904;9517.048295170565;9526.237900967906;9536.666216682383;9599.32804703678;8872.290216782641;9262;9395.671151509665;9411.10594493522;9435.339526233098;7128.750493732695;7182.3535881770895;7232.638368081575;7237.348638622444;7335.083114610674;5403.108487099585;5476.698781567052;5616.522595579258;5661.603687741983;5663.150527420919;8853.247473964528;8854.158854908774;8863.379563430499;8874.378793484653;8912.643494260157;8166.4283500154415;8570.442921210102;8635.093315201813;8878.600462979311;8903.020667726416;6216.627002379872;6669.399754022162;6689.899651505329;6914.585124892523;6914.896276555755;7392.22381649919;7411.777646670608;7424.517406368569;7446.73936412223;7489.176190618919;6477.676116194078;6686.231083425274;6690.966545167243;6734;6760.526763126534;6614.933850661432;6671.432928201158;6707.832304192434;6766.7969960901255;6855.383015528427;6410.583312084699;6453.193350831146;6492.707828147839;6520.315366886409;6539.901901471387;4733.171694953438;4778;4848.684835485823;4877.097736918681;4923.852284431473;4540.636749060001;4675.13510000651;4752.334673145831;4758.571728544448;4773.570378665937 08:48:35 INFO - PROCESS | 28821 | |4;prototype.html;315.98883572567775;324.8278412441406;334.8258905369208;334.867727247737;335.17212485161645;5341.305630268064;5407.188921661753;5435.619506634537;5508.531774799142;5524.171374293858;5355.169948657955;5382.9730851345785;5410.540104091147;5416.972915135429;5421.9457805422035;4200.68494862885;4210.55789142141;4224.429701990222;4233.7883105844585;4237.110206856564;4113.691473139512;4171.812268447912;4210.62104410603;4239.597238262376;4244.342126970325;4175.102352994106;4176.770277634729;4177.811998460076;4187.476565429321;4193.916121677565;4170.374443833419;4194.853180138696;4206.831726730927;4218.008767939563;4225.556316586775;3651.470536772153;3724.2551489701896;3735.3089678409583;3739.2895349883433;3741.9251614967548;5093.490650934914;5134.89469317578;5139.5330241483925;5143.434222235551;5156.613254005927;4869.586085182764;4910.582600478963;4916.557509824097;4920.507949205086;4934.61978544698;5428.348598168205;5758.683272420015;5759.913601295984;5761.308642962829;5773.971130144322;3982.9601703983167;3991.481107456012;3991.7604943703473;3999.060220848098;4003.7597744135155;5739.196512488255;5837.562182836262;5994.730237139339;6062.242219722535;6103.1455596216565;4085.3667681509414;4089.9591004090175;4092.263392589303;4094.5086589609436;4110.835566577303;4160;4175.62419382257;4180.581941805856;4181.142865712522;4193.490343476346;4661.347411362412;4809.398825146856;4811.398575178103;4811.591014763714;4828.855134345975;5725.656460612377;5728.169415434739;5741.162827895034;5744.425557444306;5746.82190151018;1436.920969346696;1457.6720237946377;1459.6861674739982;1460.7802484925207;1462.5612316305067;960.3616408069769;964.3008818606454;978.4276198424002;978.9510524473748;988.906053924876;4928.743170491502;4947.975260123749;4949.826756063592;4955.628327875424;4977.576905963034;5902.8819423611285;5915.231019967377;5940.6435613863305;5949.851253718692;5962.940370596325;4839.951600484021;4931.630127740434;4943.604511639061;4963.627727920348;4972.290101894476;3181.2206009527813;3190.680931906837;3196.5045417960255;3208.406444807718;3213.196700824794;5560.360558535739;5570.944290557042;5580.414056524088;5585.134304182858;5592.161175823659;5914.201582786269;6136.079588061826;6155.538334624921;6155.815325540241;6179.134921111048;5546.001719690414;5564.721763911788;5579.525740312119;5602.5517958562405;5603.831885043455;5840.678762667924;5932.288125424804;5963.105534169909;5963.105534169909;5966.433188847052;5830.76676932918;5834.212381328466;5845.09401042839;5864.736086876186;5868.2077919480325;5283.788648454019;5369.275147855145;5500.669959802424;5542.7782888684005;5569.387367389665;4088.4684990950987;4107.096438783463;4120.114175452292;4132.173565286895;4144.5026596808575;5792.247007888947;5895.64626122434;5966.971229781895;5978.163057171912;5997.730102145327;5748.252727145612;5759.63854819522;5763.397876327295;5783.768649254151;5784.132380143013;5755.740991655469;5755.827325180251;5772.913406298993;5775.133729940375;5784.595078344475;5564.860878478071;5660.264165658438;5665.178549110438;5678.659280443187;5680.715964201856;5781.682007489629;5786.710664466844;5797.884042319214;5827.271591051119;5837.912431313619;5507.9449205507435;5648.124540696199;5652.491275785034;5692.1461780733225;5692.6299790513485 08:48:35 INFO - PROCESS | 28821 | |5;yui.html;745.7278093495873;751.3726038757637;752.9598256303562;770.9784535490477;790.1032328307372;10952.34285942843;11335.319880807157;11336.943315283412;11366.886331136686;11379.544818207261;11762.17664763467;11785.351805650685;13398.866011339884;13823.101498402597;13863.722725545484;786.5949036246324;807.6446363599997;807.725373373053;812.8658771302757;815.7919730468723;643.6652940470975;799.6321692021648;812.5490352854164;812.9715459958902;814.5112932240638;836.0928392693935;837.1419295222385;838.9244967952883;841.9284360829337;848.2747251100313;845.1675100026499;845.7251393297203;846.3102571404286;848.5375470368633;850.4854562989395;613.9662318572476;614.5820841827556;618.9350118237566;622.0979579609584;625.8153844615849;11946.342951137683;11953.820692689616;11970.281783093042;11975.640730778003;11981.161318707695;12585.496580136783;12647.304398258093;12751.61745147647;12776.52573244653;12928.48286068556;9853.211743060538;10141;10164.491775411274;10481.213908956783;10572.207084468695;3261.5107733839877;3281;3323.2356557991557;3414.590249170091;3421.1789170599127;46207;46554.76722616399;46937.29594056092;46946.5305346949;47412.5258747415;9500.334976551714;9772.413655180711;9780.853287200698;9937.602495900228;10131.746706332253;17197.1401429928;17366.21852016662;17370.739438908426;17419.04195269247;17444.47666570005;6728.687905858408;6774.525783195129;6890.035395044698;7118.644067796589;7142.607156606437;3833.271678381099;3845.134844659985;3858.884233473;3863.9806800966376;3876;2736.3979924416594;2771.4457108578363;2774.2786875412135;2791.6091747155415;3152.180433087414;579.1833514744275;580.7415700013454;582.3274118393263;590.1708100119339;594.8631814682648;519.7401299350324;631.5263552335748;647.1813156357211;648.5946283572767;649.5453182771984;7493.4005279577505;7854.567998760123;7925.064882118402;7939.880901786478;8285.212904774036;552.8562573730859;601.2574470528893;607.9422454866781;613.187526527353;646.6411141816243;3534.699550538233;3661.707063434972;3672.247189326182;3761.7181096025092;3806.8286927088348;54638.72680636571;54781.45218547763;54876;55263.447365526634;55531;47594;47818;47838.52161478341;48449;48886.511134888904;43327.56672433298;43366.56633433689;44376.77811610986;44407;45038.324425132996;6893.655317234018;6950.096487456598;6989.965050174716;7004.3696067354185;7007.124109486314;28689.569656455587;28806.135815925554;29022.709772902846;29310.41379172362;29392.412151756416;32591.18522036968;33413.16467088245;34021;37729.434058488594;39502.457217420364;10277.794444110927;10679;10699.304545204537;11454.713632159262;11655.30068195911;12107.878921210675;12219.938900305442;12288.938555307166;12293.262404255773;12382.876171238173;11117.888821112008;11156.888431115585;11174.553017879194;11374.090072794323;11887.227330223508;11370.715732106764;11470.19708620422;11717.414129293671;12216.144869859025;12312.692182695504;10847.566097356017;11363.715907102389;11451.541938322707;11594.420278986187;11813.409329533317;9010.369274150746;9210.309226808151;9241.722748317561;9384.812303754023;9456.243500519804;9098.590563424794;9973.900260997298;9978.101970822661;10003.199744020607;10016.59933602677 08:48:35 INFO - PROCESS | 28821 | __end_tp_report 08:48:35 INFO - PROCESS | 28821 | __start_cc_report 08:48:35 INFO - PROCESS | 28821 | _x_x_mozilla_cycle_collect,376 08:48:35 INFO - PROCESS | 28821 | __end_cc_report 08:48:35 INFO - PROCESS | 28821 | __startTimestamp1461340115837__endTimestamp 08:48:35 INFO - PROCESS | 28821 | 08:48:35 INFO - PROCESS | 28821 | ------- Summary: start ------- 08:48:35 INFO - PROCESS | 28821 | Number of tests: 6 08:48:35 INFO - PROCESS | 28821 | 08:48:35 INFO - PROCESS | 28821 | [#0] dojo.html Cycles:165 Average:4762.15 Median:4894.90 stddev:500.10 (10.2%) stddev-sans-first:472.65 08:48:35 INFO - PROCESS | 28821 | Values: 2623.4 2701.3 2724.0 2736.8 2738.9 4733.8 4772.7 4780.9 4784.5 4816.1 4638.4 4797.6 4799.3 4876.3 4885.4 4420.5 4446.3 4490.5 4495.7 4530.2 4432.1 4488.2 4511.4 4529.8 4530.3 4357.7 4440.8 4461.8 4486.0 4511.4 4393.5 4429.2 4445.8 4451.3 4489.6 4380.7 4385.6 4391.1 4399.9 4438.0 4684.8 4739.3 4773.6 4785.3 4812.9 5165.2 5175.7 5186.6 5188.5 5217.2 5096.7 5156.0 5175.6 5176.5 5181.9 4832.7 4895.1 4907.3 4932.2 4934.5 5307.4 5337.9 5346.9 5347.7 5409.1 4961.7 5060.8 5099.8 5113.1 5115.8 5106.7 5123.5 5129.7 5140.8 5179.9 5044.5 5091.6 5170.5 5197.1 5207.7 4985.9 5159.0 5203.4 5206.5 5208.5 4331.2 4334.6 4337.5 4365.6 4372.5 3760.6 3797.5 3813.3 3816.6 3833.6 4307.0 4421.4 4456.5 4460.5 4480.5 5157.2 5192.4 5195.5 5197.9 5243.8 4391.1 4422.1 4424.3 4470.6 4474.6 4551.9 4654.3 4656.6 4680.0 4725.0 4681.2 4700.1 4728.4 4768.5 4786.0 4972.2 5008.9 5030.5 5052.6 5090.2 4728.2 4779.3 4826.6 4850.9 4875.9 5062.3 5081.7 5092.7 5115.1 5150.0 5147.3 5152.7 5160.2 5160.9 5185.5 4887.1 4909.7 5002.7 5122.7 5136.4 5013.5 5037.9 5069.4 5074.2 5093.4 4894.9 4906.0 4927.6 4932.1 4963.8 4915.0 4947.4 5041.0 5158.9 5179.9 4956.7 4960.1 5007.7 5013.4 5069.5 08:48:35 INFO - PROCESS | 28821 | 08:48:35 INFO - PROCESS | 28821 | [#1] ext.html Cycles:180 Average:43513.37 Median:34853.98 stddev:76547.77 (219.6%) stddev-sans-first:76694.62 08:48:35 INFO - PROCESS | 28821 | Values: 576.3 602.7 612.4 621.8 639.4 33828.0 34817.8 34894.5 35002.8 35108.8 39248.8 39949.0 39949.4 40103.2 40110.8 7653.5 7719.3 7792.5 7820.4 7831.8 7658.3 7744.4 7749.4 7749.9 7762.1 7749.5 7808.8 7813.0 7823.5 7825.9 7672.6 7722.3 7743.1 7763.0 7786.7 7660.3 7726.6 7759.8 7767.5 7776.2 28826.7 36315.3 36739.4 36751.8 36838.0 3062.9 3187.3 3235.8 3278.8 3475.5 27314.5 27474.0 27549.3 27586.3 27786.2 3223.8 3231.7 3241.5 3303.4 3344.2 242633.0 250322.0 250492.0 250540.0 251262.0 33816.0 57964.8 58699.4 58720.0 58782.4 33861.5 34319.8 34619.8 34753.8 34815.5 12593.3 12723.1 12829.4 12840.4 12855.2 10373.2 10395.4 10409.0 10529.0 10574.7 8386.7 8431.7 8446.7 8470.5 8507.5 3319.6 3353.8 3356.1 3372.3 3378.8 920.2 920.9 950.4 957.0 1086.7 27458.3 28678.0 28727.3 28850.4 29186.7 992.2 997.7 1030.1 1041.5 1060.3 14684.8 15216.6 15297.3 15450.1 15518.8 354519.0 358682.0 361678.0 363397.2 364387.0 49800.8 50385.2 50456.5 50703.7 50834.5 1130.6 1189.8 1238.3 1243.9 1255.1 26804.9 27587.7 27840.0 28493.3 28509.3 42401.0 42429.8 42529.6 42710.8 42756.6 248363.0 248779.0 249187.0 249839.0 249976.0 25886.7 26358.5 26387.5 39218.6 40545.6 37511.4 37538.6 38487.8 40307.2 41372.4 34778.7 35400.6 35411.0 35710.6 35964.1 34112.5 34566.0 35040.6 35209.1 35488.1 30207.0 34510.3 34890.1 38984.0 39614.4 30546.3 31561.2 32015.2 32117.5 32196.4 24990.4 25073.6 25150.0 25288.0 25370.7 08:48:35 INFO - PROCESS | 28821 | 08:48:35 INFO - PROCESS | 28821 | [#2] jquery.html Cycles:180 Average:24309.63 Median:24020.74 stddev:67444.05 (280.8%) stddev-sans-first:67609.31 08:48:35 INFO - PROCESS | 28821 | Values: 380.0 388.3 389.4 392.9 404.3 12873.4 15550.3 15687.5 16299.4 16317.3 16050.4 16202.1 16243.4 16806.7 17156.0 4944.8 5053.9 5141.3 5156.2 5170.8 5287.2 5292.9 5327.0 5328.8 5333.5 5197.7 5300.3 5500.6 5506.4 5510.8 5441.5 5451.0 5452.0 5453.2 5491.7 5090.5 5379.3 5406.1 5408.6 5418.7 11493.2 12176.3 12406.9 12698.5 12702.5 1876.8 1931.1 1961.1 2080.9 2505.0 8733.4 8794.6 9258.5 9467.9 9778.0 1753.5 1761.5 1783.7 1822.3 1824.3 65004.3 65731.7 66281.7 67469.7 67593.0 10199.3 10221.5 10269.4 10332.7 10447.7 12719.7 13589.6 14361.8 14381.6 14448.1 6837.6 6847.6 6900.7 6909.3 7026.1 6052.5 6136.3 6148.5 6177.3 6293.8 4323.0 4411.7 4421.6 4424.2 4472.8 1859.1 1884.6 1899.7 1907.6 1913.3 838.2 842.0 886.3 940.6 944.4 16495.7 16527.3 16731.4 16787.5 17301.6 873.4 883.8 942.2 944.1 954.5 7978.9 9316.8 9798.7 10008.4 10032.6 394984.0 410786.0 412951.0 414014.0 414033.0 77969.6 78194.6 78590.6 78814.6 80370.6 927.2 947.2 962.9 970.6 973.3 15800.3 15991.8 16072.4 16094.9 16274.4 26677.5 34330.7 35734.5 35862.0 36294.3 43629.8 45386.8 46424.8 46925.0 47255.0 7662.4 7689.7 7699.3 7769.8 7886.2 10440.6 11500.8 11579.0 11822.9 11942.4 10240.4 10346.4 10374.5 10441.3 10476.9 10204.3 10309.1 10349.9 10470.6 10474.8 9794.8 10072.3 10263.8 10354.9 10892.5 7936.8 8013.0 8026.4 8027.5 8129.0 8028.8 9524.2 10551.1 10568.7 10701.3 08:48:35 INFO - PROCESS | 28821 | 08:48:35 INFO - PROCESS | 28821 | [#3] mootools.html Cycles:180 Average:5138.79 Median:5481.48 stddev:2795.69 (51.0%) stddev-sans-first:2789.55 08:48:35 INFO - PROCESS | 28821 | Values: 1418.1 1474.5 1561.8 1741.6 1756.9 6850.3 7505.0 7529.1 7763.5 7764.0 7548.7 7578.2 7612.1 7619.8 7661.8 2224.4 2244.1 2244.7 2257.7 2260.0 2204.9 2257.0 2260.4 2269.2 2282.7 2230.5 2241.6 2250.7 2254.8 2282.0 2183.1 2183.4 2192.5 2198.5 2199.3 2172.1 2186.8 2198.8 2203.2 2214.2 7646.8 7691.2 7705.9 7735.3 7754.8 4456.4 4579.4 4586.9 4591.5 4600.5 2808.4 2910.4 2914.0 2922.8 2933.7 899.8 903.1 910.5 915.9 939.0 10442.6 10503.7 10529.4 10563.2 10566.1 4203.0 4315.7 4389.3 4432.8 4436.6 9002.2 9038.4 9062.4 9070.0 9108.4 4595.8 4611.2 4619.9 4630.6 4630.6 3702.1 4154.2 4235.4 4246.3 4246.6 3564.9 3610.2 3629.1 3679.0 3728.3 1235.5 1240.6 1253.5 1265.7 1268.2 758.5 796.6 833.5 884.6 894.7 5320.7 5344.3 5434.3 5441.1 5486.3 887.0 892.9 915.0 930.4 935.7 3699.6 3812.1 3820.9 3857.1 3889.6 9229.9 9517.0 9526.2 9536.7 9599.3 8872.3 9262.0 9395.7 9411.1 9435.3 7128.8 7182.4 7232.6 7237.3 7335.1 5403.1 5476.7 5616.5 5661.6 5663.2 8853.2 8854.2 8863.4 8874.4 8912.6 8166.4 8570.4 8635.1 8878.6 8903.0 6216.6 6669.4 6689.9 6914.6 6914.9 7392.2 7411.8 7424.5 7446.7 7489.2 6477.7 6686.2 6691.0 6734.0 6760.5 6614.9 6671.4 6707.8 6766.8 6855.4 6410.6 6453.2 6492.7 6520.3 6539.9 4733.2 4778.0 4848.7 4877.1 4923.9 4540.6 4675.1 4752.3 4758.6 4773.6 08:48:35 INFO - PROCESS | 28821 | 08:48:35 INFO - PROCESS | 28821 | [#4] prototype.html Cycles:180 Average:4744.11 Median:5408.86 stddev:1393.31 (25.8%) stddev-sans-first:1357.00 08:48:35 INFO - PROCESS | 28821 | Values: 316.0 324.8 334.8 334.9 335.2 5341.3 5407.2 5435.6 5508.5 5524.2 5355.2 5383.0 5410.5 5417.0 5421.9 4200.7 4210.6 4224.4 4233.8 4237.1 4113.7 4171.8 4210.6 4239.6 4244.3 4175.1 4176.8 4177.8 4187.5 4193.9 4170.4 4194.9 4206.8 4218.0 4225.6 3651.5 3724.3 3735.3 3739.3 3741.9 5093.5 5134.9 5139.5 5143.4 5156.6 4869.6 4910.6 4916.6 4920.5 4934.6 5428.3 5758.7 5759.9 5761.3 5774.0 3983.0 3991.5 3991.8 3999.1 4003.8 5739.2 5837.6 5994.7 6062.2 6103.1 4085.4 4090.0 4092.3 4094.5 4110.8 4160.0 4175.6 4180.6 4181.1 4193.5 4661.3 4809.4 4811.4 4811.6 4828.9 5725.7 5728.2 5741.2 5744.4 5746.8 1436.9 1457.7 1459.7 1460.8 1462.6 960.4 964.3 978.4 979.0 988.9 4928.7 4948.0 4949.8 4955.6 4977.6 5902.9 5915.2 5940.6 5949.9 5962.9 4840.0 4931.6 4943.6 4963.6 4972.3 3181.2 3190.7 3196.5 3208.4 3213.2 5560.4 5570.9 5580.4 5585.1 5592.2 5914.2 6136.1 6155.5 6155.8 6179.1 5546.0 5564.7 5579.5 5602.6 5603.8 5840.7 5932.3 5963.1 5963.1 5966.4 5830.8 5834.2 5845.1 5864.7 5868.2 5283.8 5369.3 5500.7 5542.8 5569.4 4088.5 4107.1 4120.1 4132.2 4144.5 5792.2 5895.6 5967.0 5978.2 5997.7 5748.3 5759.6 5763.4 5783.8 5784.1 5755.7 5755.8 5772.9 5775.1 5784.6 5564.9 5660.3 5665.2 5678.7 5680.7 5781.7 5786.7 5797.9 5827.3 5837.9 5507.9 5648.1 5652.5 5692.1 5692.6 08:48:35 INFO - PROCESS | 28821 | 08:48:35 INFO - PROCESS | 28821 | [#5] yui.html Cycles:180 Average:12881.27 Median:44722.66 stddev:14742.32 (33.0%) stddev-sans-first:14755.51 08:48:35 INFO - PROCESS | 28821 | Values: 745.7 751.4 753.0 771.0 790.1 10952.3 11335.3 11336.9 11366.9 11379.5 11762.2 11785.4 13398.9 13823.1 13863.7 786.6 807.6 807.7 812.9 815.8 643.7 799.6 812.5 813.0 814.5 836.1 837.1 838.9 841.9 848.3 845.2 845.7 846.3 848.5 850.5 614.0 614.6 618.9 622.1 625.8 11946.3 11953.8 11970.3 11975.6 11981.2 12585.5 12647.3 12751.6 12776.5 12928.5 9853.2 10141.0 10164.5 10481.2 10572.2 3261.5 3281.0 3323.2 3414.6 3421.2 46207.0 46554.8 46937.3 46946.5 47412.5 9500.3 9772.4 9780.9 9937.6 10131.7 17197.1 17366.2 17370.7 17419.0 17444.5 6728.7 6774.5 6890.0 7118.6 7142.6 3833.3 3845.1 3858.9 3864.0 3876.0 2736.4 2771.4 2774.3 2791.6 3152.2 579.2 580.7 582.3 590.2 594.9 519.7 631.5 647.2 648.6 649.5 7493.4 7854.6 7925.1 7939.9 8285.2 552.9 601.3 607.9 613.2 646.6 3534.7 3661.7 3672.2 3761.7 3806.8 54638.7 54781.5 54876.0 55263.4 55531.0 47594.0 47818.0 47838.5 48449.0 48886.5 43327.6 43366.6 44376.8 44407.0 45038.3 6893.7 6950.1 6990.0 7004.4 7007.1 28689.6 28806.1 29022.7 29310.4 29392.4 32591.2 33413.2 34021.0 37729.4 39502.5 10277.8 10679.0 10699.3 11454.7 11655.3 12107.9 12219.9 12288.9 12293.3 12382.9 11117.9 11156.9 11174.6 11374.1 11887.2 11370.7 11470.2 11717.4 12216.1 12312.7 10847.6 11363.7 11451.5 11594.4 11813.4 9010.4 9210.3 9241.7 9384.8 9456.2 9098.6 9973.9 9978.1 10003.2 10016.6 08:48:35 INFO - PROCESS | 28821 | -------- Summary: end -------- 08:48:35 INFO - PROCESS | 28821 | 08:48:36 INFO - TEST-INFO | 28821: exit 0 08:48:36 INFO - TEST-OK | dromaeo_css | took 1115382ms 08:48:36 INFO - TEST-START | kraken 08:48:36 INFO - operating with platform_type : linux_ 08:48:36 INFO - Initialising browser for kraken test... 08:48:36 INFO - TEST-INFO | started process 29055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq9haQE/profile http://localhost:34686/getInfo.html) 08:48:40 INFO - PROCESS | 29055 | 08:48:40 INFO - PROCESS | 29055 | (process:29123): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:48:41 INFO - PROCESS | 29055 | __metrics Screen width/height:1600/1200 08:48:41 INFO - PROCESS | 29055 | colorDepth:24 08:48:41 INFO - PROCESS | 29055 | Browser inner width/height: 1024/697 08:48:41 INFO - PROCESS | 29055 | __metrics 08:48:41 ERROR - PROCESS | 29055 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:48:42 INFO - TEST-INFO | 29055: exit 0 08:48:42 INFO - Browser initialized. 08:48:42 INFO - Running cycle 1/1 for kraken test... 08:48:42 INFO - TEST-INFO | started process 29174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq9haQE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:44 INFO - PROCESS | 29174 | 08:48:44 INFO - PROCESS | 29174 | (process:29236): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:48:54 INFO - PROCESS | 29174 | RSS: Main: 165048320 08:48:54 INFO - PROCESS | 29174 | 08:48:57 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34686/tests/kraken/driver.html?testName=audio-beat-detection) 08:48:58 INFO - PROCESS | 29174 | RSS: Main: 169754624 08:48:58 INFO - PROCESS | 29174 | 08:49:01 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34686/tests/kraken/driver.html?testName=audio-dft) 08:49:01 INFO - PROCESS | 29174 | RSS: Main: 172883968 08:49:01 INFO - PROCESS | 29174 | 08:49:04 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34686/tests/kraken/driver.html?testName=audio-fft) 08:49:05 INFO - PROCESS | 29174 | RSS: Main: 163254272 08:49:05 INFO - PROCESS | 29174 | 08:49:07 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34686/tests/kraken/driver.html?testName=audio-oscillator) 08:49:08 INFO - PROCESS | 29174 | RSS: Main: 164474880 08:49:08 INFO - PROCESS | 29174 | 08:49:10 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34686/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:49:11 INFO - PROCESS | 29174 | RSS: Main: 165048320 08:49:11 INFO - PROCESS | 29174 | 08:49:14 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34686/tests/kraken/driver.html?testName=imaging-darkroom) 08:49:15 INFO - PROCESS | 29174 | RSS: Main: 165445632 08:49:15 INFO - PROCESS | 29174 | 08:49:18 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34686/tests/kraken/driver.html?testName=imaging-desaturate) 08:49:19 INFO - PROCESS | 29174 | RSS: Main: 165134336 08:49:19 INFO - PROCESS | 29174 | 08:49:22 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34686/tests/kraken/driver.html?testName=json-parse-financial) 08:49:22 INFO - PROCESS | 29174 | RSS: Main: 165322752 08:49:22 INFO - PROCESS | 29174 | 08:49:24 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34686/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:49:25 INFO - PROCESS | 29174 | RSS: Main: 165670912 08:49:25 INFO - PROCESS | 29174 | 08:49:26 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34686/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:49:27 INFO - PROCESS | 29174 | RSS: Main: 165261312 08:49:27 INFO - PROCESS | 29174 | 08:49:29 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34686/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:49:30 INFO - PROCESS | 29174 | RSS: Main: 166658048 08:49:30 INFO - PROCESS | 29174 | 08:49:33 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:49:33 INFO - PROCESS | 29174 | RSS: Main: 166268928 08:49:33 INFO - PROCESS | 29174 | 08:49:36 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:49:37 INFO - PROCESS | 29174 | RSS: Main: 166469632 08:49:37 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | Cycle 1(1): loaded http://localhost:34686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34686/tests/kraken/driver.html?testName=ai-astar) 08:49:39 INFO - PROCESS | 29174 | RSS: Main: 168361984 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | __start_tp_report 08:49:39 INFO - PROCESS | 29174 | _x_x_mozilla_page_load 08:49:39 INFO - PROCESS | 29174 | _x_x_mozilla_page_load_details 08:49:39 INFO - PROCESS | 29174 | |i|pagename|runs| 08:49:39 INFO - PROCESS | 29174 | |0;ai-astar;120;108;115;114;115;128;115;115;115;114 08:49:39 INFO - PROCESS | 29174 | |1;audio-beat-detection;160;133;159;197;132;167;160;141;198;133 08:49:39 INFO - PROCESS | 29174 | |2;audio-dft;163;162;164;168;166;163;171;163;165;173 08:49:39 INFO - PROCESS | 29174 | |3;audio-fft;75;76;78;171;78;73;77;79;162;77 08:49:39 INFO - PROCESS | 29174 | |4;audio-oscillator;94;95;143;95;95;96;151;94;95;141 08:49:39 INFO - PROCESS | 29174 | |5;imaging-gaussian-blur;117;117;118;118;117;117;118;118;117;118 08:49:39 INFO - PROCESS | 29174 | |6;imaging-darkroom;147;147;147;149;147;147;148;148;146;146 08:49:39 INFO - PROCESS | 29174 | |7;imaging-desaturate;95;96;96;95;95;95;94;95;95;96 08:49:39 INFO - PROCESS | 29174 | |8;json-parse-financial;67;67;67;66;65;67;71;83;65;68 08:49:39 INFO - PROCESS | 29174 | |9;json-stringify-tinderbox;64;65;64;65;65;65;65;64;64;64 08:49:39 INFO - PROCESS | 29174 | |10;stanford-crypto-aes;79;80;77;87;81;88;80;87;80;80 08:49:39 INFO - PROCESS | 29174 | |11;stanford-crypto-ccm;135;141;137;143;133;133;135;133;168;149 08:49:39 INFO - PROCESS | 29174 | |12;stanford-crypto-pbkdf2;182;184;175;175;175;174;172;173;175;170 08:49:39 INFO - PROCESS | 29174 | |13;stanford-crypto-sha256-iterative;74;73;74;74;73;72;74;71;74;73 08:49:39 INFO - PROCESS | 29174 | __end_tp_report 08:49:39 INFO - PROCESS | 29174 | __start_cc_report 08:49:39 INFO - PROCESS | 29174 | _x_x_mozilla_cycle_collect,926 08:49:39 INFO - PROCESS | 29174 | __end_cc_report 08:49:39 INFO - PROCESS | 29174 | __startTimestamp1461340179587__endTimestamp 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | ------- Summary: start ------- 08:49:39 INFO - PROCESS | 29174 | Number of tests: 14 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#0] ai-astar Cycles:10 Average:115.90 Median:115.00 stddev:5.13 (4.5%) stddev-sans-first:5.22 08:49:39 INFO - PROCESS | 29174 | Values: 120.0 108.0 115.0 114.0 115.0 128.0 115.0 115.0 115.0 114.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#1] audio-beat-detection Cycles:10 Average:158.00 Median:160.00 stddev:24.55 (15.3%) stddev-sans-first:26.03 08:49:39 INFO - PROCESS | 29174 | Values: 160.0 133.0 159.0 197.0 132.0 167.0 160.0 141.0 198.0 133.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:3.74 (2.3%) stddev-sans-first:3.82 08:49:39 INFO - PROCESS | 29174 | Values: 163.0 162.0 164.0 168.0 166.0 163.0 171.0 163.0 165.0 173.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#3] audio-fft Cycles:10 Average:94.60 Median:77.00 stddev:37.99 (49.3%) stddev-sans-first:39.63 08:49:39 INFO - PROCESS | 29174 | Values: 75.0 76.0 78.0 171.0 78.0 73.0 77.0 79.0 162.0 77.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:95.00 stddev:24.36 (25.6%) stddev-sans-first:25.14 08:49:39 INFO - PROCESS | 29174 | Values: 94.0 95.0 143.0 95.0 95.0 96.0 151.0 94.0 95.0 141.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:49:39 INFO - PROCESS | 29174 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 118.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 08:49:39 INFO - PROCESS | 29174 | Values: 147.0 147.0 147.0 149.0 147.0 147.0 148.0 148.0 146.0 146.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:49:39 INFO - PROCESS | 29174 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#8] json-parse-financial Cycles:10 Average:68.60 Median:67.00 stddev:5.34 (8.0%) stddev-sans-first:5.63 08:49:39 INFO - PROCESS | 29174 | Values: 67.0 67.0 67.0 66.0 65.0 67.0 71.0 83.0 65.0 68.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:49:39 INFO - PROCESS | 29174 | Values: 64.0 65.0 64.0 65.0 65.0 65.0 65.0 64.0 64.0 64.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:80.50 stddev:3.90 (4.8%) stddev-sans-first:3.99 08:49:39 INFO - PROCESS | 29174 | Values: 79.0 80.0 77.0 87.0 81.0 88.0 80.0 87.0 80.0 80.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:139.00 stddev:10.93 (7.9%) stddev-sans-first:11.40 08:49:39 INFO - PROCESS | 29174 | Values: 135.0 141.0 137.0 143.0 133.0 133.0 135.0 133.0 168.0 149.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:175.00 stddev:4.30 (2.5%) stddev-sans-first:3.87 08:49:39 INFO - PROCESS | 29174 | Values: 182.0 184.0 175.0 175.0 175.0 174.0 172.0 173.0 175.0 170.0 08:49:39 INFO - PROCESS | 29174 | 08:49:39 INFO - PROCESS | 29174 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:74.00 stddev:1.03 (1.4%) stddev-sans-first:1.05 08:49:39 INFO - PROCESS | 29174 | Values: 74.0 73.0 74.0 74.0 73.0 72.0 74.0 71.0 74.0 73.0 08:49:39 INFO - PROCESS | 29174 | -------- Summary: end -------- 08:49:39 INFO - PROCESS | 29174 | 08:49:40 INFO - TEST-INFO | 29174: exit 0 08:49:40 INFO - TEST-OK | kraken | took 64189ms 08:49:40 INFO - SUITE-END | took 1179s 08:49:40 INFO - Completed test suite (00:19:39) 08:49:40 INFO - javascript benchmark 08:49:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.449075694104, 2701.311165652759, 2723.986380068099, 2736.767374773144, 2738.9178324650265, 4733.8106475741015, 4772.717109937442, 4780.928286075712, 4784.497627749089, 4816.060868130716, 4638.3970083889135, 4797.592204662608, 4799.256115302125, 4876.268559716044, 4885.364902562662, 4420.469543654766, 4446.288593824988, 4490.483594386638, 4495.707778994371, 4530.22986092365, 4432.135733531963, 4488.214562451574, 4511.436070491189, 4529.841455549056, 4530.252508336121, 4357.651387888961, 4440.822367105328, 4461.754603496806, 4486.035502367007, 4511.413516242867, 4393.450818647669, 4429.15845989261, 4445.8221671133115, 4451.310046942729, 4489.573490518395, 4380.7152535085115, 4385.561443855589, 4391.099824535962, 4399.912001759979, 4438.045820148651, 4684.812607495696, 4739.312799644033, 4773.618110551182, 4785.258284965836, 4812.903741925142, 5165.225216217597, 5175.689458632456, 5186.559142472895, 5188.507091826308, 5217.217417387385, 5096.694198348111, 5155.9688062387295, 5175.637705360627, 5176.482351764831, 5181.896362072737, 4832.661713680044, 4895.143349913751, 4907.263910413467, 4932.21084626458, 4934.506549345073, 5307.416184219733, 5337.946620533823, 5346.893062138735, 5347.652402593819, 5409.134538473904, 4961.677490963076, 5060.797568097309, 5099.796008159707, 5113.1052065888325, 5115.846524604268, 5106.744662766847, 5123.513266239701, 5129.743512824344, 5140.7943682253035, 5179.896402071938, 5044.470330615306, 5091.643584949018, 5170.482951704799, 5197.116490196676, 5207.739613019334, 4985.90028199434, 5158.97420512895, 5203.401608815035, 5206.505381988705, 5208.479152084761, 4331.242032644274, 4334.609885110355, 4337.4795024596615, 4365.607095361433, 4372.453443319585, 3760.567534733486, 3797.468354430382, 3813.332666783357, 3816.580176180618, 3833.5974722654278, 4307.030918043415, 4421.38100665907, 4456.509783923766, 4460.531644177379, 4480.507144214133, 5157.174852023733, 5192.402873669501, 5195.506426889439, 5197.948020519746, 5243.842684719464, 4391.099824535962, 4422.115576884636, 4424.269995450714, 4470.642348612103, 4474.619657329098, 4551.863444096616, 4654.325122857167, 4656.557627025427, 4679.9532004680195, 4725.031368569435, 4681.227597446519, 4700.059988002482, 4728.361671174416, 4768.451628062817, 4785.95214047862, 4972.204447288416, 5008.899822003466, 5030.496950304941, 5052.570531504716, 5090.160123579568, 4728.243481043017, 4779.30700048498, 4826.58973987201, 4850.927236091391, 4875.853724388274, 5062.31658726082, 5081.745912704276, 5092.694438333712, 5115.104856650146, 5150.0472412603785, 5147.253648221062, 5152.690838549699, 5160.174372100446, 5160.922586161286, 5185.533302002837, 4887.144749668865, 4909.68087074339, 5002.699838009731, 5122.743862806919, 5136.409312928911, 5013.548780609763, 5037.949620503748, 5069.442361340323, 5074.213496907985, 5093.363329583802, 4894.9021019578695, 4905.950940490549, 4927.556519913225, 4932.1122198004705, 4963.8262660806695, 4914.99242655262, 4947.431045429822, 5041.0, 5158.922616160836, 5179.922301165561, 4956.727379994135, 4960.107180707363, 5007.7496125192865, 5013.373328333958, 5069.493050694901], "value": 4730.3491668429315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.3026737647447, 602.6866029664575, 612.3723183736666, 621.7637297826825, 639.4468784501402, 33827.98516044516, 34817.82591087047, 34894.476582851275, 35002.824985875064, 35108.82445587775, 39248.80375598118, 39949.0, 39949.400758988566, 40103.19793604126, 40110.7994460028, 7653.464257501977, 7719.305262526372, 7792.532448053135, 7820.41346898982, 7831.765047048598, 7658.2724641159275, 7744.380449564022, 7749.418793590475, 7749.883751743729, 7762.146163921964, 7749.496282741632, 7808.804779880492, 7813.02337207849, 7823.491473054261, 7825.882611760828, 7672.616369181575, 7722.304992550669, 7743.148253692089, 7762.961185194038, 7786.688532458723, 7660.310572048543, 7726.613669316512, 7759.7672069838, 7767.456278060538, 7776.183500732454, 28826.711732882613, 36315.27369452596, 36739.4489082664, 36751.81624091889, 36838.0, 3062.8621712023014, 3187.2669286064333, 3235.805851648885, 3278.8032718036993, 3475.461303497962, 27314.45371092567, 27474.0, 27549.31126721828, 27586.310342241402, 27786.16641500758, 3223.758218133626, 3231.74146068314, 3241.546183534307, 3303.4053870303337, 3344.1973926257765, 242633.0, 250322.0, 250492.0, 250540.0, 251262.0, 33816.0, 57964.78316951494, 58699.41300587025, 58720.0, 58782.4121758777, 33861.49207761885, 34319.828400857834, 34619.82690086534, 34753.82623086868, 34815.4777678335, 12593.307368094842, 12723.109382343147, 12829.422675979604, 12840.422181001877, 12855.16441431304, 10373.222008349405, 10395.376277423378, 10409.0, 10529.0, 10574.682759517227, 8386.706465273686, 8431.662733490715, 8446.704365347183, 8470.534120623302, 8507.489550626859, 3319.618243901982, 3353.832308384571, 3356.0901549694822, 3372.3086767212662, 3378.831058447068, 920.2270093121809, 920.9401388909699, 950.4154944709093, 957.0423024611039, 1086.7283179205199, 27458.313542161206, 28678.0, 28727.2818179543, 28850.42299154005, 29186.708132918822, 992.245893121233, 997.6531682228933, 1030.0677886512717, 1041.5417216424748, 1060.2790102730064, 14684.779728304084, 15216.56534954402, 15297.311620977083, 15450.0729956203, 15518.767218491732, 354519.0, 358682.0, 361678.0, 363397.18301408325, 364387.0, 49800.750996245515, 50385.244221335975, 50456.49543504518, 50703.74648126736, 50834.491655083715, 1130.6325444230492, 1189.7858385490695, 1238.349866320171, 1243.8631750507436, 1255.1151438236022, 26804.865975669996, 27587.724122758515, 27840.0, 28493.287667808472, 28509.28726781764, 42401.0, 42429.787851060544, 42529.57470425256, 42710.78644606757, 42756.5724342765, 248363.0, 248779.0, 249187.0, 249839.0, 249976.0, 25886.741132589188, 26358.472830542898, 26387.472250555264, 39218.607813921495, 40545.59454405536, 37511.43732843955, 37538.55999360033, 38487.807560962014, 40307.1938561233, 41372.379414308205, 34778.652213477544, 35400.64599354076, 35411.0, 35710.64289357177, 35964.100897476725, 34112.48831267483, 34566.0, 35040.64959350476, 35209.119772005906, 35488.11279718028, 30207.0, 34510.309793803484, 34890.12774680552, 38984.0, 39614.40578391269, 30546.31995240283, 31561.21096972594, 32015.199620009687, 32117.518237226926, 32196.35607287794, 24990.37524061913, 25073.623895641216, 25150.0, 25288.0, 25370.746292536838], "value": 16380.743724148148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.9905002374942, 388.2855545795736, 389.35251938266754, 392.90766669832584, 404.346979627901, 12873.420696068675, 15550.300236489356, 15687.45093921713, 16299.429519966803, 16317.265723042461, 16050.43823466179, 16202.108884011375, 16243.431479898176, 16806.663866722687, 17156.0, 4944.7774850131655, 5053.9241911371355, 5141.30592370029, 5156.20078887773, 5170.793168273283, 5287.206918962167, 5292.947070529284, 5327.041132596131, 5328.813491527797, 5333.546648534879, 5197.688138711689, 5300.310959575269, 5500.614956953015, 5506.421825708303, 5510.779568817243, 5441.537469315113, 5450.972745136289, 5451.972740136293, 5453.209284653703, 5491.725413729318, 5090.54185123337, 5379.273798037254, 5406.08096623575, 5408.567314614821, 5418.674879507243, 11493.195476316661, 12176.330301833395, 12406.937965310206, 12698.492060317576, 12702.491900323976, 1876.7747870255657, 1931.1033449825263, 1961.1076959983316, 2080.8751474911555, 2505.023041014006, 8733.388662793606, 8794.648214071429, 9258.490783006931, 9467.905320946771, 9777.951110244474, 1753.5353131420184, 1761.4979730776668, 1783.7056885613858, 1822.261983896524, 1824.270291883244, 65004.34995650077, 65731.67134164298, 66281.66859165674, 67469.66265168643, 67593.0, 10199.337043092175, 10221.488925553842, 10269.383836969806, 10332.690019299433, 10447.738806529898, 12719.745605087846, 13589.59231223045, 14361.784573231409, 14381.6404589884, 14448.133112013313, 6837.589744615339, 6847.623380714009, 6900.654967251618, 6909.30906909305, 7026.051483049825, 6052.485538729169, 6136.325004249529, 6148.538859585549, 6177.289611694623, 6293.779717709858, 4323.01711818844, 4411.691181617256, 4421.5578442156175, 4424.247877860771, 4472.843450479218, 1859.0983373064053, 1884.6419180355688, 1899.7435346228083, 1907.5898681783483, 1913.3112079651314, 838.1995194589152, 841.9705310314232, 886.2555453419159, 940.6002448959165, 944.4333399959969, 16495.670086598202, 16527.33890644361, 16731.414400496167, 16787.54617098589, 17301.56746081358, 873.4279047223952, 883.8453270677734, 942.1708896171325, 944.1172503709054, 954.5179684259543, 7978.880316795253, 9316.813663726687, 9798.706038818847, 10008.399496030115, 10032.598696052077, 394984.0, 410786.0, 412951.0, 414014.0, 414033.0, 77969.61015194887, 78194.6090269545, 78590.60704696554, 78814.60592697, 80370.59814701007, 927.1840780113591, 947.1996163242187, 962.8796400449944, 970.6263088710897, 973.2603221551672, 15800.288986995844, 15991.840081599501, 16072.35710571564, 16094.919525402298, 16274.430394936595, 26677.46645067049, 34330.65669343275, 35734.46398303976, 35862.0, 36294.27411451809, 43629.78185109181, 45386.77306613446, 46424.76787616176, 46925.0, 47255.0, 7662.387009039375, 7689.692412303445, 7699.307062364414, 7769.7669069928, 7886.171951944963, 10440.582376704846, 11500.82748758786, 11579.0, 11822.940885295518, 11942.402879856147, 10240.385576865114, 10346.37921724699, 10374.533146008296, 10441.269111162146, 10476.947615261875, 10204.336718113298, 10309.07218350352, 10349.896501034893, 10470.581176752845, 10474.842877356998, 9794.804103918024, 10072.345297555636, 10263.794724105626, 10354.896451035393, 10892.509837057192, 7936.801579960547, 8013.0, 8026.43814932949, 8027.518348899085, 8129.0, 8028.759137225892, 9524.190443812076, 10551.103156231806, 10568.735781605214, 10701.250912436055], "value": 8079.619727896767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.07824913806, 1474.51341057451, 1561.836007219242, 1741.6342568060707, 1756.8770186086963, 6850.3492168244065, 7505.0, 7529.134149572801, 7763.456558040946, 7764.0, 7548.660310286036, 7578.204288549706, 7612.086549614054, 7619.771406857803, 7661.808454788633, 2224.377174391173, 2244.136007637055, 2244.685743995834, 2257.683924250606, 2259.9887000564972, 2204.9448763780874, 2257.0407576779885, 2260.42359198405, 2269.171752310403, 2282.7032485776826, 2230.486987992763, 2241.607718649238, 2250.696156018941, 2254.842161048727, 2281.9657705134355, 2183.1049269799387, 2183.4323076000355, 2192.48476607997, 2198.4723666320047, 2199.2632468123197, 2172.055156007142, 2186.8250539956766, 2198.8240940724863, 2203.22886989554, 2214.247155966979, 7646.770596882103, 7691.153973062958, 7705.8844117338285, 7735.303822655932, 7754.844903101963, 4456.376107344942, 4579.404677391918, 4586.885327866797, 4591.471980722226, 4600.539946005406, 2808.3540785619216, 2910.359720861407, 2913.970860291391, 2922.7807914406294, 2933.7212964768314, 899.820035992804, 903.0608167505786, 910.5219759626183, 915.8580420034905, 938.9812203755887, 10442.582296708122, 10503.684889453329, 10529.420881851494, 10563.154947604173, 10566.101881340095, 4202.957970420318, 4315.654747620183, 4389.275769497997, 4432.84485043022, 4436.64506839452, 9002.189802917768, 9038.367314287936, 9062.410943288665, 9069.954650226839, 9108.362414630912, 4595.770211489412, 4611.239145541015, 4619.8845028873875, 4630.6063984561015, 4630.629549636021, 3702.074481379655, 4154.189932963043, 4235.449391579075, 4246.341817018367, 4246.617804397619, 3564.875229367012, 3610.205754733954, 3629.1471504196493, 3679.0, 3728.3475391806323, 1235.4749231576543, 1240.6154092231436, 1253.5361916091106, 1265.6835791052238, 1268.2390565660714, 758.4652819762055, 796.625585974591, 833.4582521361164, 884.6461415433878, 894.6600291889171, 5320.733963301819, 5344.305240318811, 5434.2935418395355, 5441.075017246998, 5486.259354987025, 886.9733907982771, 892.9285657147412, 915.0254978447931, 930.4463844012802, 935.6771913689767, 3699.574548926854, 3812.066043819282, 3820.9235815284096, 3857.0550215197454, 3889.6110388961442, 9229.907700922904, 9517.048295170565, 9526.237900967906, 9536.666216682383, 9599.32804703678, 8872.290216782641, 9262.0, 9395.671151509665, 9411.10594493522, 9435.339526233098, 7128.750493732695, 7182.3535881770895, 7232.638368081575, 7237.348638622444, 7335.083114610674, 5403.108487099585, 5476.698781567052, 5616.522595579258, 5661.603687741983, 5663.150527420919, 8853.247473964528, 8854.158854908774, 8863.379563430499, 8874.378793484653, 8912.643494260157, 8166.4283500154415, 8570.442921210102, 8635.093315201813, 8878.600462979311, 8903.020667726416, 6216.627002379872, 6669.399754022162, 6689.899651505329, 6914.585124892523, 6914.896276555755, 7392.22381649919, 7411.777646670608, 7424.517406368569, 7446.73936412223, 7489.176190618919, 6477.676116194078, 6686.231083425274, 6690.966545167243, 6734.0, 6760.526763126534, 6614.933850661432, 6671.432928201158, 6707.832304192434, 6766.7969960901255, 6855.383015528427, 6410.583312084699, 6453.193350831146, 6492.707828147839, 6520.315366886409, 6539.901901471387, 4733.171694953438, 4778.0, 4848.684835485823, 4877.097736918681, 4923.852284431473, 4540.636749060001, 4675.13510000651, 4752.334673145831, 4758.571728544448, 4773.570378665937], "value": 4180.983524040788, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.98883572567775, 324.8278412441406, 334.8258905369208, 334.867727247737, 335.17212485161645, 5341.305630268064, 5407.188921661753, 5435.619506634537, 5508.531774799142, 5524.171374293858, 5355.169948657955, 5382.9730851345785, 5410.540104091147, 5416.972915135429, 5421.9457805422035, 4200.68494862885, 4210.55789142141, 4224.429701990222, 4233.7883105844585, 4237.110206856564, 4113.691473139512, 4171.812268447912, 4210.62104410603, 4239.597238262376, 4244.342126970325, 4175.102352994106, 4176.770277634729, 4177.811998460076, 4187.476565429321, 4193.916121677565, 4170.374443833419, 4194.853180138696, 4206.831726730927, 4218.008767939563, 4225.556316586775, 3651.470536772153, 3724.2551489701896, 3735.3089678409583, 3739.2895349883433, 3741.9251614967548, 5093.490650934914, 5134.89469317578, 5139.5330241483925, 5143.434222235551, 5156.613254005927, 4869.586085182764, 4910.582600478963, 4916.557509824097, 4920.507949205086, 4934.61978544698, 5428.348598168205, 5758.683272420015, 5759.913601295984, 5761.308642962829, 5773.971130144322, 3982.9601703983167, 3991.481107456012, 3991.7604943703473, 3999.060220848098, 4003.7597744135155, 5739.196512488255, 5837.562182836262, 5994.730237139339, 6062.242219722535, 6103.1455596216565, 4085.3667681509414, 4089.9591004090175, 4092.263392589303, 4094.5086589609436, 4110.835566577303, 4160.0, 4175.62419382257, 4180.581941805856, 4181.142865712522, 4193.490343476346, 4661.347411362412, 4809.398825146856, 4811.398575178103, 4811.591014763714, 4828.855134345975, 5725.656460612377, 5728.169415434739, 5741.162827895034, 5744.425557444306, 5746.82190151018, 1436.920969346696, 1457.6720237946377, 1459.6861674739982, 1460.7802484925207, 1462.5612316305067, 960.3616408069769, 964.3008818606454, 978.4276198424002, 978.9510524473748, 988.906053924876, 4928.743170491502, 4947.975260123749, 4949.826756063592, 4955.628327875424, 4977.576905963034, 5902.8819423611285, 5915.231019967377, 5940.6435613863305, 5949.851253718692, 5962.940370596325, 4839.951600484021, 4931.630127740434, 4943.604511639061, 4963.627727920348, 4972.290101894476, 3181.2206009527813, 3190.680931906837, 3196.5045417960255, 3208.406444807718, 3213.196700824794, 5560.360558535739, 5570.944290557042, 5580.414056524088, 5585.134304182858, 5592.161175823659, 5914.201582786269, 6136.079588061826, 6155.538334624921, 6155.815325540241, 6179.134921111048, 5546.001719690414, 5564.721763911788, 5579.525740312119, 5602.5517958562405, 5603.831885043455, 5840.678762667924, 5932.288125424804, 5963.105534169909, 5963.105534169909, 5966.433188847052, 5830.76676932918, 5834.212381328466, 5845.09401042839, 5864.736086876186, 5868.2077919480325, 5283.788648454019, 5369.275147855145, 5500.669959802424, 5542.7782888684005, 5569.387367389665, 4088.4684990950987, 4107.096438783463, 4120.114175452292, 4132.173565286895, 4144.5026596808575, 5792.247007888947, 5895.64626122434, 5966.971229781895, 5978.163057171912, 5997.730102145327, 5748.252727145612, 5759.63854819522, 5763.397876327295, 5783.768649254151, 5784.132380143013, 5755.740991655469, 5755.827325180251, 5772.913406298993, 5775.133729940375, 5784.595078344475, 5564.860878478071, 5660.264165658438, 5665.178549110438, 5678.659280443187, 5680.715964201856, 5781.682007489629, 5786.710664466844, 5797.884042319214, 5827.271591051119, 5837.912431313619, 5507.9449205507435, 5648.124540696199, 5652.491275785034, 5692.1461780733225, 5692.6299790513485], "value": 4300.09136302946, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.7278093495873, 751.3726038757637, 752.9598256303562, 770.9784535490477, 790.1032328307372, 10952.34285942843, 11335.319880807157, 11336.943315283412, 11366.886331136686, 11379.544818207261, 11762.17664763467, 11785.351805650685, 13398.866011339884, 13823.101498402597, 13863.722725545484, 786.5949036246324, 807.6446363599997, 807.725373373053, 812.8658771302757, 815.7919730468723, 643.6652940470975, 799.6321692021648, 812.5490352854164, 812.9715459958902, 814.5112932240638, 836.0928392693935, 837.1419295222385, 838.9244967952883, 841.9284360829337, 848.2747251100313, 845.1675100026499, 845.7251393297203, 846.3102571404286, 848.5375470368633, 850.4854562989395, 613.9662318572476, 614.5820841827556, 618.9350118237566, 622.0979579609584, 625.8153844615849, 11946.342951137683, 11953.820692689616, 11970.281783093042, 11975.640730778003, 11981.161318707695, 12585.496580136783, 12647.304398258093, 12751.61745147647, 12776.52573244653, 12928.48286068556, 9853.211743060538, 10141.0, 10164.491775411274, 10481.213908956783, 10572.207084468695, 3261.5107733839877, 3281.0, 3323.2356557991557, 3414.590249170091, 3421.1789170599127, 46207.0, 46554.76722616399, 46937.29594056092, 46946.5305346949, 47412.5258747415, 9500.334976551714, 9772.413655180711, 9780.853287200698, 9937.602495900228, 10131.746706332253, 17197.1401429928, 17366.21852016662, 17370.739438908426, 17419.04195269247, 17444.47666570005, 6728.687905858408, 6774.525783195129, 6890.035395044698, 7118.644067796589, 7142.607156606437, 3833.271678381099, 3845.134844659985, 3858.884233473, 3863.9806800966376, 3876.0, 2736.3979924416594, 2771.4457108578363, 2774.2786875412135, 2791.6091747155415, 3152.180433087414, 579.1833514744275, 580.7415700013454, 582.3274118393263, 590.1708100119339, 594.8631814682648, 519.7401299350324, 631.5263552335748, 647.1813156357211, 648.5946283572767, 649.5453182771984, 7493.4005279577505, 7854.567998760123, 7925.064882118402, 7939.880901786478, 8285.212904774036, 552.8562573730859, 601.2574470528893, 607.9422454866781, 613.187526527353, 646.6411141816243, 3534.699550538233, 3661.707063434972, 3672.247189326182, 3761.7181096025092, 3806.8286927088348, 54638.72680636571, 54781.45218547763, 54876.0, 55263.447365526634, 55531.0, 47594.0, 47818.0, 47838.52161478341, 48449.0, 48886.511134888904, 43327.56672433298, 43366.56633433689, 44376.77811610986, 44407.0, 45038.324425132996, 6893.655317234018, 6950.096487456598, 6989.965050174716, 7004.3696067354185, 7007.124109486314, 28689.569656455587, 28806.135815925554, 29022.709772902846, 29310.41379172362, 29392.412151756416, 32591.18522036968, 33413.16467088245, 34021.0, 37729.434058488594, 39502.457217420364, 10277.794444110927, 10679.0, 10699.304545204537, 11454.713632159262, 11655.30068195911, 12107.878921210675, 12219.938900305442, 12288.938555307166, 12293.262404255773, 12382.876171238173, 11117.888821112008, 11156.888431115585, 11174.553017879194, 11374.090072794323, 11887.227330223508, 11370.715732106764, 11470.19708620422, 11717.414129293671, 12216.144869859025, 12312.692182695504, 10847.566097356017, 11363.715907102389, 11451.541938322707, 11594.420278986187, 11813.409329533317, 9010.369274150746, 9210.309226808151, 9241.722748317561, 9384.812303754023, 9456.243500519804, 9098.590563424794, 9973.900260997298, 9978.101970822661, 10003.199744020607, 10016.59933602677], "value": 5991.213371123363, "unit": "score"}], "name": "dromaeo_css", "value": 6380.013672880966, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 108.0, 115.0, 114.0, 115.0, 128.0, 115.0, 115.0, 115.0, 114.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 133.0, 159.0, 197.0, 132.0, 167.0, 160.0, 141.0, 198.0, 133.0], "value": 158.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 168.0, 166.0, 163.0, 171.0, 163.0, 165.0, 173.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 171.0, 78.0, 73.0, 77.0, 79.0, 162.0, 77.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 143.0, 95.0, 95.0, 96.0, 151.0, 94.0, 95.0, 141.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 147.0, 147.0, 148.0, 148.0, 146.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 65.0, 67.0, 71.0, 83.0, 65.0, 68.0], "value": 68.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 77.0, 87.0, 81.0, 88.0, 80.0, 87.0, 80.0, 80.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 141.0, 137.0, 143.0, 133.0, 133.0, 135.0, 133.0, 168.0, 149.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 175.0, 175.0, 175.0, 174.0, 172.0, 173.0, 175.0, 170.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 74.0, 73.0, 72.0, 74.0, 71.0, 74.0, 73.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1608.5, "alertThreshold": 2.0}]} 08:49:40 INFO - Return code: 0 08:49:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:49:40 ERROR - # TBPL SUCCESS # 08:49:40 INFO - Running post-action listener: _resource_record_post_action 08:49:40 INFO - Running post-run listener: _resource_record_post_run 08:49:41 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518017024; Read time: 232; Write time: 467200 08:49:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234438656; Read time: 0; Write time: 275624 08:49:41 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283480064; Read time: 232; Write time: 191576 08:49:41 INFO - Running post-run listener: _upload_blobber_files 08:49:41 INFO - Blob upload gear active. 08:49:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:49:41 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 08:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:49:42 INFO - (blobuploader) - INFO - Open directory for files ... 08:49:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:49:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:49:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:43 INFO - (blobuploader) - INFO - Done attempting. 08:49:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:49:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:49:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:43 INFO - (blobuploader) - INFO - Done attempting. 08:49:43 INFO - (blobuploader) - INFO - Iteration through files over. 08:49:43 INFO - Return code: 0 08:49:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:49:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:49:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dedc299b2b057133124bc4cd8604bc767f608666f2d5eda243e8bb98de3e747847d518041a577aef2a77aa6f52b9ead1a723012d71e440c347a99569e15ac6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/becc2ac81fe64b27ba91420542b8a16354cee78713e7225dd5a2b25d756e825c96c1975cf3c96c8791352fa5840fe90677a6ae5d9f343eee7f26cc5e0d526044"} 08:49:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:49:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:49:43 INFO - Contents: 08:49:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dedc299b2b057133124bc4cd8604bc767f608666f2d5eda243e8bb98de3e747847d518041a577aef2a77aa6f52b9ead1a723012d71e440c347a99569e15ac6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/becc2ac81fe64b27ba91420542b8a16354cee78713e7225dd5a2b25d756e825c96c1975cf3c96c8791352fa5840fe90677a6ae5d9f343eee7f26cc5e0d526044"} 08:49:43 INFO - Running post-run listener: copy_logs_to_upload_dir 08:49:43 INFO - Copying logs to upload dir... 08:49:43 INFO - mkdir: /builds/slave/test/build/upload/logs 08:49:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.987509 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 08:49:43.321719) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 08:49:43.325332) ========= 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=82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dedc299b2b057133124bc4cd8604bc767f608666f2d5eda243e8bb98de3e747847d518041a577aef2a77aa6f52b9ead1a723012d71e440c347a99569e15ac6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/becc2ac81fe64b27ba91420542b8a16354cee78713e7225dd5a2b25d756e825c96c1975cf3c96c8791352fa5840fe90677a6ae5d9f343eee7f26cc5e0d526044"} build_url:https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/WMnVIniZSOG1FFhv6HT4cw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dedc299b2b057133124bc4cd8604bc767f608666f2d5eda243e8bb98de3e747847d518041a577aef2a77aa6f52b9ead1a723012d71e440c347a99569e15ac6c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/becc2ac81fe64b27ba91420542b8a16354cee78713e7225dd5a2b25d756e825c96c1975cf3c96c8791352fa5840fe90677a6ae5d9f343eee7f26cc5e0d526044"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 08:49:43.349366) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:49:43.349659) ========= 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=82e07478c745e68b1fe4678a000001bc-1461338936.586588-863554089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:49:43.433499) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 08:49:43.433790) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 08:49:43.434083) ========= ========= Total master_lag: 0.18 =========