builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1461647143.89 results: success (0) buildid: 20160425193111 builduid: 6d74e9ca59d6446f930933cb67d43374 revision: cfc7ebe592937ad937cebe04fdad4213eee72fae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:43.886232) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:43.886792) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:43.887593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:43.918605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:43.918907) ========= 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-1461643529.448870-377606384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 22:05:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-04-25 22:05:44 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129320 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:44.061427) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:44.061763) ========= 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-1461643529.448870-377606384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017874 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:44.112217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:44.112526) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cfc7ebe592937ad937cebe04fdad4213eee72fae --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 cfc7ebe592937ad937cebe04fdad4213eee72fae --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-1461643529.448870-377606384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 22:05:45,025 truncating revision to first 12 chars 2016-04-25 22:05:45,025 Setting DEBUG logging. 2016-04-25 22:05:45,025 attempt 1/10 2016-04-25 22:05:45,025 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cfc7ebe59293?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 22:05:45,297 unpacking tar archive at: mozilla-central-cfc7ebe59293/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577660 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:44.702874) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:44.703214) ========= script_repo_revision: cfc7ebe592937ad937cebe04fdad4213eee72fae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:44.703646) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:44.703928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 22:05:44.712945) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-25 22:05:44.713280) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1461643529.448870-377606384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:05:45 INFO - MultiFileLogger online at 20160425 22:05:45 in /builds/slave/test 22:05:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:05:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:05:45 INFO - {'append_to_log': False, 22:05:45 INFO - 'base_work_dir': '/builds/slave/test', 22:05:45 INFO - 'blob_upload_branch': 'Firefox', 22:05:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:05:45 INFO - 'branch': 'Firefox', 22:05:45 INFO - 'buildbot_json_path': 'buildprops.json', 22:05:45 INFO - 'config_files': ('talos/linux_config.py',), 22:05:45 INFO - 'default_actions': ('clobber', 22:05:45 INFO - 'read-buildbot-config', 22:05:45 INFO - 'download-and-extract', 22:05:45 INFO - 'populate-webroot', 22:05:45 INFO - 'create-virtualenv', 22:05:45 INFO - 'install', 22:05:45 INFO - 'run-tests'), 22:05:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:05:45 INFO - 'download_minidump_stackwalk': True, 22:05:45 INFO - 'download_symbols': 'ondemand', 22:05:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:05:45 INFO - 'tooltool.py': '/tools/tooltool.py', 22:05:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:05:45 INFO - '/tools/misc-python/virtualenv.py')}, 22:05:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:05:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:05:45 INFO - 'installer_path': 'installer.exe', 22:05:45 INFO - 'log_level': 'info', 22:05:45 INFO - 'log_name': 'talos', 22:05:45 INFO - 'log_to_console': True, 22:05:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:05:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:05:45 INFO - 'opt_config_files': (), 22:05:45 INFO - 'pip_index': False, 22:05:45 INFO - 'sps_profile': False, 22:05:45 INFO - 'sps_profile_interval': 0, 22:05:45 INFO - 'suite': 'dromaeojs', 22:05:45 INFO - 'system_bits': '32', 22:05:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:05:45 INFO - 'title': 'talos-linux64-ix-055', 22:05:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:05:45 INFO - 'use_talos_json': True, 22:05:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:05:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:05:45 INFO - 'work_dir': 'build'} 22:05:45 INFO - ##### 22:05:45 INFO - ##### Running clobber step. 22:05:45 INFO - ##### 22:05:45 INFO - Running pre-action listener: _resource_record_pre_action 22:05:45 INFO - Running main action method: clobber 22:05:45 INFO - rmtree: /builds/slave/test/build 22:05:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:05:46 INFO - Running post-action listener: _resource_record_post_action 22:05:46 INFO - ##### 22:05:46 INFO - ##### Running read-buildbot-config step. 22:05:46 INFO - ##### 22:05:46 INFO - Running pre-action listener: _resource_record_pre_action 22:05:46 INFO - Running main action method: read_buildbot_config 22:05:46 INFO - Using buildbot properties: 22:05:46 INFO - { 22:05:46 INFO - "project": "", 22:05:46 INFO - "product": "firefox", 22:05:46 INFO - "script_repo_revision": "production", 22:05:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:05:46 INFO - "repository": "", 22:05:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:05:46 INFO - "buildid": "20160425193111", 22:05:46 INFO - "pgo_build": "True", 22:05:46 INFO - "basedir": "/builds/slave/test", 22:05:46 INFO - "buildnumber": 755, 22:05:46 INFO - "slavename": "talos-linux64-ix-055", 22:05:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:05:46 INFO - "platform": "ubuntu64_hw", 22:05:46 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:05:46 INFO - "branch": "mozilla-central", 22:05:46 INFO - "repo_path": "mozilla-central", 22:05:46 INFO - "revision": "cfc7ebe592937ad937cebe04fdad4213eee72fae", 22:05:46 INFO - "stage_platform": "linux64-pgo", 22:05:46 INFO - "builduid": "6d74e9ca59d6446f930933cb67d43374", 22:05:46 INFO - "slavebuilddir": "test" 22:05:46 INFO - } 22:05:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:05:46 INFO - Running post-action listener: _resource_record_post_action 22:05:46 INFO - ##### 22:05:46 INFO - ##### Running download-and-extract step. 22:05:46 INFO - ##### 22:05:46 INFO - Running pre-action listener: _resource_record_pre_action 22:05:46 INFO - Running main action method: download_and_extract 22:05:46 INFO - mkdir: /builds/slave/test/build/tests 22:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:46 INFO - https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:05:55 INFO - Downloaded 1361 bytes. 22:05:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:05:55 INFO - Using the following test package requirements: 22:05:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:05:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:05:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:05:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:55 INFO - u'jsshell-linux-x86_64.zip'], 22:05:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:05:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:05:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:05:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:05:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:05:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:05:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:05:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:55 INFO - https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:05:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:05:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:05:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:05:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:06:09 INFO - Downloaded 23862654 bytes. 22:06:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:06:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:06:10 INFO - Return code: 0 22:06:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:06:10 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')]} 22:06:10 INFO - https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:06:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:06:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:06:11 INFO - Downloaded 23862654 bytes. 22:06:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:06:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:06:13 INFO - Return code: 0 22:06:13 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')]} 22:06:13 INFO - https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:06:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:06:14 INFO - Downloaded 10840145 bytes. 22:06:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:06:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:06:14 INFO - Return code: 0 22:06: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')]} 22:06:14 INFO - https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:06:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:06:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:06:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:06:16 INFO - Downloaded 58370244 bytes. 22:06:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:06:16 INFO - mkdir: /builds/slave/test/properties 22:06:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:06:16 INFO - Writing to file /builds/slave/test/properties/build_url 22:06:16 INFO - Contents: 22:06:16 INFO - build_url:https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:06:17 INFO - Running post-action listener: _resource_record_post_action 22:06:17 INFO - Running post-action listener: set_extra_try_arguments 22:06:17 INFO - ##### 22:06:17 INFO - ##### Running populate-webroot step. 22:06:17 INFO - ##### 22:06:17 INFO - Running pre-action listener: _resource_record_pre_action 22:06:17 INFO - Running main action method: populate_webroot 22:06:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:06:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:06:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:06:18 INFO - '--tppagecycles', 22:06:18 INFO - '7'], 22:06:18 INFO - 'tests': ['tsvgm']}}, 22:06:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:06:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:06:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:06:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:06:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:06:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:06:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:18 INFO - 'talos_options': ['--disable-e10s'], 22:06:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:18 INFO - 'talos_options': ['--disable-e10s'], 22:06:18 INFO - 'tests': ['damp', 'tps']}, 22:06:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:18 INFO - 'tests': ['damp', 'tps']}, 22:06:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:06:18 INFO - 'tests': ['dromaeo_dom']}, 22:06:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:06:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:06:18 INFO - 'tests': ['a11yr', 22:06:18 INFO - 'ts_paint', 22:06:18 INFO - 'tpaint', 22:06:18 INFO - 'sessionrestore', 22:06:18 INFO - 'sessionrestore_no_auto_restore', 22:06:18 INFO - 'tabpaint']}, 22:06:18 INFO - 'other-e10s': {'tests': ['a11yr', 22:06:18 INFO - 'ts_paint', 22:06:18 INFO - 'tpaint', 22:06:18 INFO - 'sessionrestore', 22:06:18 INFO - 'sessionrestore_no_auto_restore', 22:06:18 INFO - 'tabpaint']}, 22:06:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:06:18 INFO - 'ts_paint', 22:06:18 INFO - 'tpaint', 22:06:18 INFO - 'sessionrestore', 22:06:18 INFO - 'sessionrestore_no_auto_restore', 22:06:18 INFO - 'tabpaint']}, 22:06:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:06:18 INFO - 'ts_paint', 22:06:18 INFO - 'tpaint', 22:06:18 INFO - 'sessionrestore', 22:06:18 INFO - 'sessionrestore_no_auto_restore', 22:06:18 INFO - 'tabpaint']}, 22:06:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:06:18 INFO - 'tests': ['a11yr', 22:06:18 INFO - 'ts_paint', 22:06:18 INFO - 'tpaint', 22:06:18 INFO - 'sessionrestore', 22:06:18 INFO - 'sessionrestore_no_auto_restore', 22:06:18 INFO - 'tabpaint']}, 22:06:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:06:18 INFO - 'tests': ['a11yr', 22:06:18 INFO - 'ts_paint', 22:06:18 INFO - 'tpaint', 22:06:18 INFO - 'sessionrestore', 22:06:18 INFO - 'sessionrestore_no_auto_restore', 22:06:18 INFO - 'tabpaint']}, 22:06:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:06:18 INFO - 'tests': ['tsvgx', 22:06:18 INFO - 'tsvgr_opacity', 22:06:18 INFO - 'tart', 22:06:18 INFO - 'tscrollx', 22:06:18 INFO - 'cart']}, 22:06:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:06:18 INFO - 'tsvgr_opacity', 22:06:18 INFO - 'tart', 22:06:18 INFO - 'tscrollx', 22:06:18 INFO - 'cart']}, 22:06:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:18 INFO - 'talos_options': ['--disable-e10s'], 22:06:18 INFO - 'tests': ['tp5o']}, 22:06:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:18 INFO - 'tests': ['tp5o']}, 22:06:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:18 INFO - 'talos_options': ['--disable-e10s', 22:06:18 INFO - '--xperf_path', 22:06:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:18 INFO - 'tests': ['tp5n']}, 22:06:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:18 INFO - 'talos_options': ['--xperf_path', 22:06:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:18 INFO - 'tests': ['tp5n']}}, 22:06:18 INFO - 'talos.zip': {'path': '', 22:06:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:06:18 INFO - Running post-action listener: _resource_record_post_action 22:06:18 INFO - ##### 22:06:18 INFO - ##### Running create-virtualenv step. 22:06:18 INFO - ##### 22:06:18 INFO - Running pre-action listener: _resource_record_pre_action 22:06:18 INFO - Running main action method: create_virtualenv 22:06:18 INFO - Creating virtualenv /builds/slave/test/build/venv 22:06: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 22:06:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:06:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:06:18 INFO - Using real prefix '/usr' 22:06:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:06:18 INFO - Installing distribute.............................................................................................................................................................................................done. 22:06:20 INFO - Installing pip.................done. 22:06:20 INFO - Return code: 0 22:06:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:06: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')]} 22:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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')]} 22:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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 0x7f7f297b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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-1461643529.448870-377606384', '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 22:06: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 22:06: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 22:06:20 INFO - Using env: {'DISPLAY': ':0', 22:06:20 INFO - 'HOME': '/home/cltbld', 22:06:20 INFO - 'LANG': 'en_US.UTF-8', 22:06:20 INFO - 'LANGUAGE': 'en_US:en', 22:06:20 INFO - 'LOGNAME': 'cltbld', 22:06:20 INFO - 'MAIL': '/var/mail/cltbld', 22:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:20 INFO - 'MOZ_NO_REMOTE': '1', 22:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:20 INFO - 'NO_EM_RESTART': '1', 22:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:20 INFO - 'PWD': '/builds/slave/test', 22:06:20 INFO - 'SHELL': '/bin/bash', 22:06:20 INFO - 'SHLVL': '1', 22:06:20 INFO - 'TERM': 'linux', 22:06:20 INFO - 'TMOUT': '86400', 22:06:20 INFO - 'USER': 'cltbld', 22:06:20 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461643529.448870-377606384', 22:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:20 INFO - '_': '/tools/buildbot/bin/python'} 22:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06: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 22:06:20 INFO - Cleaning up... 22:06:20 INFO - Return code: 0 22:06:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:06: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')]} 22:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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')]} 22:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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 0x7f7f297b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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-1461643529.448870-377606384', '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 22:06: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 22:06: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 22:06:20 INFO - Using env: {'DISPLAY': ':0', 22:06:20 INFO - 'HOME': '/home/cltbld', 22:06:20 INFO - 'LANG': 'en_US.UTF-8', 22:06:20 INFO - 'LANGUAGE': 'en_US:en', 22:06:20 INFO - 'LOGNAME': 'cltbld', 22:06:20 INFO - 'MAIL': '/var/mail/cltbld', 22:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:20 INFO - 'MOZ_NO_REMOTE': '1', 22:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:20 INFO - 'NO_EM_RESTART': '1', 22:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:20 INFO - 'PWD': '/builds/slave/test', 22:06:20 INFO - 'SHELL': '/bin/bash', 22:06:20 INFO - 'SHLVL': '1', 22:06:20 INFO - 'TERM': 'linux', 22:06:20 INFO - 'TMOUT': '86400', 22:06:20 INFO - 'USER': 'cltbld', 22:06:20 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461643529.448870-377606384', 22:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:20 INFO - '_': '/tools/buildbot/bin/python'} 22:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:21 INFO - Downloading/unpacking psutil>=0.7.1 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:06:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:06:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:06:22 INFO - Installing collected packages: psutil 22:06:22 INFO - Running setup.py install for psutil 22:06:23 INFO - building 'psutil._psutil_linux' extension 22:06: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 22:06: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 22:06:23 INFO - building 'psutil._psutil_posix' extension 22:06: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 22:06: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 22:06:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:06:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:06:23 INFO - Successfully installed psutil 22:06:23 INFO - Cleaning up... 22:06:23 INFO - Return code: 0 22:06:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:06: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')]} 22:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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')]} 22:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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 0x7f7f297b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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-1461643529.448870-377606384', '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 22:06: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 22:06: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 22:06:23 INFO - Using env: {'DISPLAY': ':0', 22:06:23 INFO - 'HOME': '/home/cltbld', 22:06:23 INFO - 'LANG': 'en_US.UTF-8', 22:06:23 INFO - 'LANGUAGE': 'en_US:en', 22:06:23 INFO - 'LOGNAME': 'cltbld', 22:06:23 INFO - 'MAIL': '/var/mail/cltbld', 22:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:23 INFO - 'MOZ_NO_REMOTE': '1', 22:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:23 INFO - 'NO_EM_RESTART': '1', 22:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:23 INFO - 'PWD': '/builds/slave/test', 22:06:23 INFO - 'SHELL': '/bin/bash', 22:06:23 INFO - 'SHLVL': '1', 22:06:23 INFO - 'TERM': 'linux', 22:06:23 INFO - 'TMOUT': '86400', 22:06:23 INFO - 'USER': 'cltbld', 22:06:23 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461643529.448870-377606384', 22:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:23 INFO - '_': '/tools/buildbot/bin/python'} 22:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:06: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) 22:06:25 INFO - Installing collected packages: mozsystemmonitor 22:06:25 INFO - Running setup.py install for mozsystemmonitor 22:06:25 INFO - Successfully installed mozsystemmonitor 22:06:25 INFO - Cleaning up... 22:06:25 INFO - Return code: 0 22:06:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:06: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')]} 22:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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')]} 22:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:25 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 0x7f7f297b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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-1461643529.448870-377606384', '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 22:06:25 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 22:06:25 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 22:06:25 INFO - Using env: {'DISPLAY': ':0', 22:06:25 INFO - 'HOME': '/home/cltbld', 22:06:25 INFO - 'LANG': 'en_US.UTF-8', 22:06:25 INFO - 'LANGUAGE': 'en_US:en', 22:06:25 INFO - 'LOGNAME': 'cltbld', 22:06:25 INFO - 'MAIL': '/var/mail/cltbld', 22:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:25 INFO - 'MOZ_NO_REMOTE': '1', 22:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:25 INFO - 'NO_EM_RESTART': '1', 22:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:25 INFO - 'PWD': '/builds/slave/test', 22:06:25 INFO - 'SHELL': '/bin/bash', 22:06:25 INFO - 'SHLVL': '1', 22:06:25 INFO - 'TERM': 'linux', 22:06:25 INFO - 'TMOUT': '86400', 22:06:25 INFO - 'USER': 'cltbld', 22:06:25 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461643529.448870-377606384', 22:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:25 INFO - '_': '/tools/buildbot/bin/python'} 22:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:26 INFO - Downloading/unpacking blobuploader==1.2.4 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06:27 INFO - Downloading blobuploader-1.2.4.tar.gz 22:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:06:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:06:27 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 22:06:27 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 22:06:27 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 22:06:27 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 22:06:27 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 22:06:27 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 22:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:06:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06:28 INFO - Downloading docopt-0.6.1.tar.gz 22:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:06:28 INFO - Installing collected packages: blobuploader, requests, docopt 22:06:28 INFO - Running setup.py install for blobuploader 22:06:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:06:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:06:28 INFO - Running setup.py install for requests 22:06:29 INFO - Running setup.py install for docopt 22:06:29 INFO - Successfully installed blobuploader requests docopt 22:06:29 INFO - Cleaning up... 22:06:29 INFO - Return code: 0 22:06:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06: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')]} 22:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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')]} 22:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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 0x7f7f297b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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-1461643529.448870-377606384', '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 22:06: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 22:06: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 22:06:29 INFO - Using env: {'DISPLAY': ':0', 22:06:29 INFO - 'HOME': '/home/cltbld', 22:06:29 INFO - 'LANG': 'en_US.UTF-8', 22:06:29 INFO - 'LANGUAGE': 'en_US:en', 22:06:29 INFO - 'LOGNAME': 'cltbld', 22:06:29 INFO - 'MAIL': '/var/mail/cltbld', 22:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:29 INFO - 'MOZ_NO_REMOTE': '1', 22:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:29 INFO - 'NO_EM_RESTART': '1', 22:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:29 INFO - 'PWD': '/builds/slave/test', 22:06:29 INFO - 'SHELL': '/bin/bash', 22:06:29 INFO - 'SHLVL': '1', 22:06:29 INFO - 'TERM': 'linux', 22:06:29 INFO - 'TMOUT': '86400', 22:06:29 INFO - 'USER': 'cltbld', 22:06:29 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461643529.448870-377606384', 22:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:29 INFO - '_': '/tools/buildbot/bin/python'} 22:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:06:29 INFO - Running setup.py (path:/tmp/pip-2dh2Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:06:29 INFO - Running setup.py (path:/tmp/pip-48sfRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:06:29 INFO - Running setup.py (path:/tmp/pip-dyvDi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:06:29 INFO - Running setup.py (path:/tmp/pip-k1h6yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:06:29 INFO - Running setup.py (path:/tmp/pip-jPli8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:06:29 INFO - Running setup.py (path:/tmp/pip-vb9uaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:06:29 INFO - Running setup.py (path:/tmp/pip-ke6KtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:06:29 INFO - Running setup.py (path:/tmp/pip-JpSIW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:06:30 INFO - Running setup.py (path:/tmp/pip-kWEaGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:06:30 INFO - Running setup.py (path:/tmp/pip-huAFq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:06:30 INFO - Running setup.py (path:/tmp/pip-H6xnvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:06:30 INFO - Running setup.py (path:/tmp/pip-DtM7Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:06:30 INFO - Running setup.py (path:/tmp/pip-M7XeBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:06:30 INFO - Running setup.py (path:/tmp/pip-EBt4YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:30 INFO - Running setup.py (path:/tmp/pip-nWBkpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:06:30 INFO - Running setup.py (path:/tmp/pip-fai_aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:06:30 INFO - Running setup.py (path:/tmp/pip-ImQL5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:06:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:06:30 INFO - Running setup.py install for manifestparser 22:06:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:06:30 INFO - Running setup.py install for mozcrash 22:06:30 INFO - Running setup.py install for mozdebug 22:06:30 INFO - Running setup.py install for mozdevice 22:06:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Running setup.py install for mozfile 22:06:31 INFO - Running setup.py install for mozhttpd 22:06:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Running setup.py install for mozinfo 22:06:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Running setup.py install for mozInstall 22:06:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Running setup.py install for mozleak 22:06:31 INFO - Running setup.py install for mozlog 22:06:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Running setup.py install for moznetwork 22:06:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Running setup.py install for mozprocess 22:06:31 INFO - Running setup.py install for mozprofile 22:06:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:06:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:06:32 INFO - Running setup.py install for mozrunner 22:06:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:06:32 INFO - Running setup.py install for mozscreenshot 22:06:32 INFO - Running setup.py install for moztest 22:06:32 INFO - Running setup.py install for mozversion 22:06:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:06:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:06:32 INFO - Cleaning up... 22:06:32 INFO - Return code: 0 22:06:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06: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')]} 22:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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')]} 22:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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 0x7f7f297b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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-1461643529.448870-377606384', '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 22:06: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 22:06: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 22:06:32 INFO - Using env: {'DISPLAY': ':0', 22:06:32 INFO - 'HOME': '/home/cltbld', 22:06:32 INFO - 'LANG': 'en_US.UTF-8', 22:06:32 INFO - 'LANGUAGE': 'en_US:en', 22:06:32 INFO - 'LOGNAME': 'cltbld', 22:06:32 INFO - 'MAIL': '/var/mail/cltbld', 22:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:32 INFO - 'MOZ_NO_REMOTE': '1', 22:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:32 INFO - 'NO_EM_RESTART': '1', 22:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:32 INFO - 'PWD': '/builds/slave/test', 22:06:32 INFO - 'SHELL': '/bin/bash', 22:06:32 INFO - 'SHLVL': '1', 22:06:32 INFO - 'TERM': 'linux', 22:06:32 INFO - 'TMOUT': '86400', 22:06:32 INFO - 'USER': 'cltbld', 22:06:32 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461643529.448870-377606384', 22:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:32 INFO - '_': '/tools/buildbot/bin/python'} 22:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:06:32 INFO - Running setup.py (path:/tmp/pip-TmUTh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:06:32 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)) 22:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:06:32 INFO - Running setup.py (path:/tmp/pip-lU46a3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:06:32 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)) 22:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:06:32 INFO - Running setup.py (path:/tmp/pip-yt0xza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:06:32 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)) 22:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:06:32 INFO - Running setup.py (path:/tmp/pip-wvwlIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:06:32 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)) 22:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:06:32 INFO - Running setup.py (path:/tmp/pip-jtficZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:06: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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:06:33 INFO - Running setup.py (path:/tmp/pip-hfNSq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:06: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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:06:33 INFO - Running setup.py (path:/tmp/pip-AADKsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:06: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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:06:33 INFO - Running setup.py (path:/tmp/pip-XpVCUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:06: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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:06:33 INFO - Running setup.py (path:/tmp/pip-64lcjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:06: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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:06:33 INFO - Running setup.py (path:/tmp/pip-E05KIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:06: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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:06:33 INFO - Running setup.py (path:/tmp/pip-LaBDqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:06: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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:06:33 INFO - Running setup.py (path:/tmp/pip-6sl0Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:06: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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:06:33 INFO - Running setup.py (path:/tmp/pip-MPKb1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:06: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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:06:33 INFO - Running setup.py (path:/tmp/pip-iwtZjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:06:33 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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:33 INFO - Running setup.py (path:/tmp/pip-BiitOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:33 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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:06:33 INFO - Running setup.py (path:/tmp/pip-zZUFyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:06:33 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)) 22:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:06:33 INFO - Running setup.py (path:/tmp/pip-fxyMoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:06:33 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)) 22:06:33 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)) 22:06:33 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)) 22:06:33 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)) 22:06:33 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)) 22:06:33 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)) 22:06:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:35 INFO - Downloading blessings-1.6.tar.gz 22:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:06:35 INFO - Installing collected packages: blessings 22:06:35 INFO - Running setup.py install for blessings 22:06:35 INFO - Successfully installed blessings 22:06:35 INFO - Cleaning up... 22:06:36 INFO - Return code: 0 22:06:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:06:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:06:36 INFO - Reading from file tmpfile_stdout 22:06:36 INFO - Current package versions: 22:06:36 INFO - argparse == 1.2.1 22:06:36 INFO - blessings == 1.6 22:06:36 INFO - blobuploader == 1.2.4 22:06:36 INFO - docopt == 0.6.1 22:06:36 INFO - manifestparser == 1.1 22:06:36 INFO - mozInstall == 1.12 22:06:36 INFO - mozcrash == 0.17 22:06:36 INFO - mozdebug == 0.1 22:06:36 INFO - mozdevice == 0.48 22:06:36 INFO - mozfile == 1.2 22:06:36 INFO - mozhttpd == 0.7 22:06:36 INFO - mozinfo == 0.9 22:06:36 INFO - mozleak == 0.1 22:06:36 INFO - mozlog == 3.1 22:06:36 INFO - moznetwork == 0.27 22:06:36 INFO - mozprocess == 0.22 22:06:36 INFO - mozprofile == 0.28 22:06:36 INFO - mozrunner == 6.11 22:06:36 INFO - mozscreenshot == 0.1 22:06:36 INFO - mozsystemmonitor == 0.0 22:06:36 INFO - moztest == 0.7 22:06:36 INFO - mozversion == 1.4 22:06:36 INFO - psutil == 3.1.1 22:06:36 INFO - requests == 1.2.3 22:06:36 INFO - wsgiref == 0.1.2 22:06:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06: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')]} 22:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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')]} 22:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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 0x7f7f297b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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-1461643529.448870-377606384', '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 22:06: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 22:06: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 22:06:36 INFO - Using env: {'DISPLAY': ':0', 22:06:36 INFO - 'HOME': '/home/cltbld', 22:06:36 INFO - 'LANG': 'en_US.UTF-8', 22:06:36 INFO - 'LANGUAGE': 'en_US:en', 22:06:36 INFO - 'LOGNAME': 'cltbld', 22:06:36 INFO - 'MAIL': '/var/mail/cltbld', 22:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:36 INFO - 'MOZ_NO_REMOTE': '1', 22:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:36 INFO - 'NO_EM_RESTART': '1', 22:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:36 INFO - 'PWD': '/builds/slave/test', 22:06:36 INFO - 'SHELL': '/bin/bash', 22:06:36 INFO - 'SHLVL': '1', 22:06:36 INFO - 'TERM': 'linux', 22:06:36 INFO - 'TMOUT': '86400', 22:06:36 INFO - 'USER': 'cltbld', 22:06:36 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461643529.448870-377606384', 22:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:36 INFO - '_': '/tools/buildbot/bin/python'} 22:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:36 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)) 22:06:36 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)) 22:06:36 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)) 22:06:36 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)) 22:06:36 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)) 22:06:36 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)) 22:06:36 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)) 22:06:36 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)) 22:06:36 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)) 22:06:36 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)) 22:06:36 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)) 22:06:36 INFO - Cleaning up... 22:06:36 INFO - Return code: 0 22:06:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:06: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')]} 22:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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')]} 22:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:36 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 0x7f7f297b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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-1461643529.448870-377606384', '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 22:06:36 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 22:06:36 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 22:06:36 INFO - Using env: {'DISPLAY': ':0', 22:06:36 INFO - 'HOME': '/home/cltbld', 22:06:36 INFO - 'LANG': 'en_US.UTF-8', 22:06:36 INFO - 'LANGUAGE': 'en_US:en', 22:06:36 INFO - 'LOGNAME': 'cltbld', 22:06:36 INFO - 'MAIL': '/var/mail/cltbld', 22:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:36 INFO - 'MOZ_NO_REMOTE': '1', 22:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:36 INFO - 'NO_EM_RESTART': '1', 22:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:36 INFO - 'PWD': '/builds/slave/test', 22:06:36 INFO - 'SHELL': '/bin/bash', 22:06:36 INFO - 'SHLVL': '1', 22:06:36 INFO - 'TERM': 'linux', 22:06:36 INFO - 'TMOUT': '86400', 22:06:36 INFO - 'USER': 'cltbld', 22:06:36 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461643529.448870-377606384', 22:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:36 INFO - '_': '/tools/buildbot/bin/python'} 22:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:36 INFO - Downloading/unpacking jsonschema 22:06:36 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 22:06:36 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 22:06:36 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 22:06:36 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 22:06:36 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 22:06:36 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 22:06:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:06:38 INFO - Downloading/unpacking functools32 (from jsonschema) 22:06:38 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 22:06:38 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 22:06:38 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 22:06:38 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 22:06:38 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 22:06:38 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 22:06:38 INFO - Downloading functools32-3.2.3-2.tar.gz 22:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:06:38 INFO - warning: no files found matching '*.txt' 22:06:38 INFO - no previously-included directories found matching 'build' 22:06:38 INFO - no previously-included directories found matching 'dist' 22:06:38 INFO - no previously-included directories found matching '.git*' 22:06:38 INFO - Installing collected packages: jsonschema, functools32 22:06:38 INFO - Running setup.py install for functools32 22:06:38 INFO - warning: no files found matching '*.txt' 22:06:38 INFO - no previously-included directories found matching 'build' 22:06:38 INFO - no previously-included directories found matching 'dist' 22:06:38 INFO - no previously-included directories found matching '.git*' 22:06:38 INFO - Successfully installed jsonschema functools32 22:06:38 INFO - Cleaning up... 22:06:38 INFO - Return code: 0 22:06:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:06:38 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')]} 22:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:38 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')]} 22:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:38 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 0x7f7f297b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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-1461643529.448870-377606384', '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 22:06:38 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 22:06:38 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 22:06:38 INFO - Using env: {'DISPLAY': ':0', 22:06:38 INFO - 'HOME': '/home/cltbld', 22:06:38 INFO - 'LANG': 'en_US.UTF-8', 22:06:38 INFO - 'LANGUAGE': 'en_US:en', 22:06:38 INFO - 'LOGNAME': 'cltbld', 22:06:38 INFO - 'MAIL': '/var/mail/cltbld', 22:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:38 INFO - 'MOZ_NO_REMOTE': '1', 22:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:38 INFO - 'NO_EM_RESTART': '1', 22:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:38 INFO - 'PWD': '/builds/slave/test', 22:06:38 INFO - 'SHELL': '/bin/bash', 22:06:38 INFO - 'SHLVL': '1', 22:06:38 INFO - 'TERM': 'linux', 22:06:38 INFO - 'TMOUT': '86400', 22:06:38 INFO - 'USER': 'cltbld', 22:06:38 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461643529.448870-377606384', 22:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:38 INFO - '_': '/tools/buildbot/bin/python'} 22:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:39 INFO - Downloading/unpacking flake8 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:06:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:06:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:06:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:06:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:06:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:06:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:06:41 INFO - no previously-included directories found matching 'docs/_build' 22:06:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:06:41 INFO - Running setup.py install for pep8 22:06:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:06:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:06:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:06:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:06:41 INFO - no previously-included directories found matching 'docs/_build' 22:06:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:06:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:06:41 INFO - Cleaning up... 22:06:42 INFO - Return code: 0 22:06:42 INFO - Running post-action listener: _resource_record_post_action 22:06:42 INFO - Running post-action listener: _start_resource_monitoring 22:06:42 INFO - Starting resource monitoring. 22:06:42 INFO - ##### 22:06:42 INFO - ##### Running install step. 22:06:42 INFO - ##### 22:06:42 INFO - Running pre-action listener: _resource_record_pre_action 22:06:42 INFO - Running main action method: install 22:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:06:42 INFO - Reading from file tmpfile_stdout 22:06:42 INFO - Detecting whether we're running mozinstall >=1.0... 22:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:06:42 INFO - Reading from file tmpfile_stdout 22:06:42 INFO - Output received: 22:06:42 INFO - Usage: mozinstall [options] installer 22:06:42 INFO - Options: 22:06:42 INFO - -h, --help show this help message and exit 22:06:42 INFO - -d DEST, --destination=DEST 22:06:42 INFO - Directory to install application into. [default: 22:06:42 INFO - "/builds/slave/test"] 22:06:42 INFO - --app=APP Application being installed. [default: firefox] 22:06:42 INFO - mkdir: /builds/slave/test/build/application 22:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:06:58 INFO - Reading from file tmpfile_stdout 22:06:58 INFO - Output received: 22:06:58 INFO - /builds/slave/test/build/application/firefox/firefox 22:06:58 INFO - Running post-action listener: _resource_record_post_action 22:06:58 INFO - ##### 22:06:58 INFO - ##### Running run-tests step. 22:06:58 INFO - ##### 22:06:58 INFO - Running pre-action listener: _resource_record_pre_action 22:06:58 INFO - Running main action method: run_tests 22:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:06:58 INFO - Python 2.7.3 22:06:58 INFO - Return code: 0 22:06:58 INFO - grabbing minidump binary from tooltool 22:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:58 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 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:06:58 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 22:06:58 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 22:06:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:06:58 INFO - Return code: 0 22:06:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:06:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:06:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:06:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:06:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:06:59 INFO - Return code: 0 22:06:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:06:59 INFO - Using env: {'DISPLAY': ':0', 22:06:59 INFO - 'HOME': '/home/cltbld', 22:06:59 INFO - 'LANG': 'en_US.UTF-8', 22:06:59 INFO - 'LANGUAGE': 'en_US:en', 22:06:59 INFO - 'LOGNAME': 'cltbld', 22:06:59 INFO - 'MAIL': '/var/mail/cltbld', 22:06:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:06:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:59 INFO - 'MOZ_NO_REMOTE': '1', 22:06:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:59 INFO - 'NO_EM_RESTART': '1', 22:06:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:59 INFO - 'PWD': '/builds/slave/test', 22:06:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:06:59 INFO - 'SHELL': '/bin/bash', 22:06:59 INFO - 'SHLVL': '1', 22:06:59 INFO - 'TERM': 'linux', 22:06:59 INFO - 'TMOUT': '86400', 22:06:59 INFO - 'USER': 'cltbld', 22:06:59 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461643529.448870-377606384', 22:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:59 INFO - '_': '/tools/buildbot/bin/python'} 22:06:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:07:00 INFO - mozversion application_buildid: 20160425193111 22:07:00 INFO - mozversion application_changeset: cfc7ebe592937ad937cebe04fdad4213eee72fae 22:07:00 INFO - mozversion application_display_name: Nightly 22:07:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:07:00 INFO - mozversion application_name: Firefox 22:07:00 INFO - mozversion application_remotingname: firefox 22:07:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:07:00 INFO - mozversion application_vendor: Mozilla 22:07:00 INFO - mozversion application_version: 49.0a1 22:07:00 INFO - mozversion platform_buildid: 20160425193111 22:07:00 INFO - mozversion platform_changeset: cfc7ebe592937ad937cebe04fdad4213eee72fae 22:07:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:07:00 INFO - mozversion platform_version: 49.0a1 22:07:00 INFO - using testdate: 1461647220 22:07:00 INFO - actual date: 1461647220 22:07:00 INFO - starting webserver on 'localhost:57341' 22:07:00 INFO - SUITE-START | Running 2 tests 22:07:00 INFO - TEST-START | dromaeo_css 22:07:00 INFO - operating with platform_type : linux_ 22:07:00 INFO - Initialising browser for dromaeo_css test... 22:07:00 INFO - TEST-INFO | started process 5857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5xOiqH/profile http://localhost:57341/getInfo.html) 22:07:03 INFO - PROCESS | 5857 | __metrics Screen width/height:1600/1200 22:07:03 INFO - PROCESS | 5857 | colorDepth:24 22:07:03 INFO - PROCESS | 5857 | Browser inner width/height: 1024/697 22:07:03 INFO - PROCESS | 5857 | __metrics 22:07:04 ERROR - PROCESS | 5857 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:07:05 INFO - TEST-INFO | 5857: exit 0 22:07:05 INFO - Browser initialized. 22:07:05 INFO - Running cycle 1/1 for dromaeo_css test... 22:07:05 INFO - TEST-INFO | started process 5938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5xOiqH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:17 INFO - PROCESS | 5938 | RSS: Main: 153956352 22:07:17 INFO - PROCESS | 5938 | 22:08:08 INFO - PROCESS | 5938 | 1461647288833 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] 22:10:16 INFO - PROCESS | 5938 | Cycle 1(1): loaded http://localhost:57341/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57341/tests/dromaeo/cssquery-ext.html) 22:10:17 INFO - PROCESS | 5938 | RSS: Main: 253235200 22:10:17 INFO - PROCESS | 5938 | 22:13:19 INFO - PROCESS | 5938 | Cycle 1(1): loaded http://localhost:57341/tests/dromaeo/cssquery-ext.html (next: http://localhost:57341/tests/dromaeo/cssquery-jquery.html) 22:13:20 INFO - PROCESS | 5938 | RSS: Main: 236118016 22:13:20 INFO - PROCESS | 5938 | 22:16:22 INFO - PROCESS | 5938 | Cycle 1(1): loaded http://localhost:57341/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57341/tests/dromaeo/cssquery-mootools.html) 22:16:23 INFO - PROCESS | 5938 | RSS: Main: 235966464 22:16:23 INFO - PROCESS | 5938 | 22:19:25 INFO - PROCESS | 5938 | Cycle 1(1): loaded http://localhost:57341/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57341/tests/dromaeo/cssquery-prototype.html) 22:19:25 INFO - PROCESS | 5938 | RSS: Main: 237977600 22:19:25 INFO - PROCESS | 5938 | 22:22:28 INFO - PROCESS | 5938 | Cycle 1(1): loaded http://localhost:57341/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57341/tests/dromaeo/cssquery-yui.html) 22:22:28 INFO - PROCESS | 5938 | RSS: Main: 225554432 22:22:28 INFO - PROCESS | 5938 | 22:25:31 INFO - PROCESS | 5938 | Cycle 1(1): loaded http://localhost:57341/tests/dromaeo/cssquery-yui.html (next: http://localhost:57341/tests/dromaeo/cssquery-dojo.html) 22:25:31 INFO - PROCESS | 5938 | RSS: Main: 270376960 22:25:31 INFO - PROCESS | 5938 | 22:25:31 INFO - PROCESS | 5938 | __start_tp_report 22:25:31 INFO - PROCESS | 5938 | _x_x_mozilla_page_load 22:25:31 INFO - PROCESS | 5938 | _x_x_mozilla_page_load_details 22:25:31 INFO - PROCESS | 5938 | |i|pagename|runs| 22:25:31 INFO - PROCESS | 5938 | |0;dojo.html;3063.8008529445583;3107.673694262101;3132.6554079051302;3146.4493713600114;3178.2848859006717;5188.118019936611;5269.5520880725135;5275.28783614212;5287.048331300364;5313.335833020872;5205.765740541675;5240.816571420001;5293.550048245894;5381.81163659272;5405.324334458192;4790.137775200463;4791.976040119804;4824.204006338968;4837.177679794426;4978.153713868633;4884.145274576953;4896.31451596775;4929.728864912428;4937.1606826839525;4965.255211718235;4737.0525894821;4745.193317136095;4807.326974223612;4890.315355850184;4904.75476226189;4763.928541071887;4768;4774.40319960005;4785.497522760095;4826.951730482685;4712.128256272601;4713.976430117862;4749.64377671676;4753.33453316536;4803.639727020487;5070.163423035195;5196.0647083524955;5272.815451459181;5302.602304827154;5322.4411436799355;5512.173174023888;5554.666719996772;5565.9443405565835;5590.692511911843;5593.021221286259;5597.468240517144;5630.493255606974;5631.042722737145;5635.633683810539;5649.519790817785;5249.028929648028;5259.105951988171;5278.366596008504;5313.9106483171245;5324.1747529133045;5763;5778.16216648592;5782.421757824184;5787.623804452697;5830.679312637761;5458.808941687102;5520.089185284463;5536.584756143306;5540.418256083134;5546.278983732089;5537.1140617501815;5541.141123125922;5541.33503979525;5566.248556444828;5592.133219351007;5523.972380138073;5526.889462210734;5528.226048353234;5528.668279903219;5535.308086489189;5472.972635136878;5518.558515318765;5552.666839989613;5597.244372009808;5600.943990560042;4246.745195288231;4251.043515209115;4258.893527661771;4291.356296555479;4292.5492823253735;3815.465834783133;3822.6559609635265;3825.2540754552597;3849.8652547160714;3863.343231650626;5106.693598384109;5190.844274671766;5297.5232229099565;5315.149576067888;5451.018816612968;5578.944210557924;5589.74846131925;5604.635698679573;5605.047141985872;5611.971940140274;5257.290265814143;5265.368155821326;5273;5281.996420680135;5347.812826551052;4747.643926705442;4825.372701548777;4838.153323168432;4901.1913034349645;4916.385451818523;5725.456081672234;5741.569382296345;5747.540196784247;5751.079827227707;5751.309842818889;5576.553875690016;5581.860453488695;5581.888362232651;5611.214429979887;5631.1271752878365;5827.3881242470625;5868.970655146697;5873.148393483007;5913.2608423947;5923.259592550931;5563.304586926634;5581.190727344593;5582.497575218087;5585.553155747449;5620.213170156099;5589.496945274945;5652.152177173457;5691.3170419549915;5717.685527296038;5726.169705392778;5391.272178255886;5544.805931792368;5545.279113715191;5548.4174161712435;5596.1605759136455;5487.725613719218;5512.889742205213;5513.173024046265;5519.144532597454;5528;5213.270142180022;5305.336832895888;5390.434004429635;5436.211749296251;5466.972665136808;5555.749991250323;5576.10782274834;5579.246801681721;5580.38615752275;5581.860453488695;5419.918701219406;5468.48049435303;5476.2333273342565;5482.23248745184;5500.3949565548555 22:25:31 INFO - PROCESS | 5938 | |1;ext.html;599.3556926304221;646.0728854094375;648.964900982932;654.6988385342748;658.8287045368203;31612.683873161262;32366.19084522888;38816.22367552651;39624.801875990655;39760.60239397605;42254.7887260564;42920.14159716804;42982.35526467105;43086;43089;8502.829943401144;8687.218150366465;8693.913060869405;8701.260392866614;8701.608427620773;7575.318221360077;7847.450678452511;9860.852087218698;10125.746856328577;10133.391996480197;10184.847227291597;10341.948290258539;10342.534585943613;10342.586296548128;10345.379277243352;7683.6926522939575;7884.64519096642;10259.281850270485;10417.374957502574;10433.373997560133;9908;10119.139873110795;10147;10147.543360548792;10150.796984060351;39156.21687566261;39588.60411395878;39790.60209397898;39880.40179397311;40043.399349009494;3674.2835147146316;3813.046738315421;3885.708571857122;4055.5336136344404;4196.81114349855;30599.69400306013;32375.352492950246;32375.86769806341;32847.507287390705;32894;3905.1408690088133;4263.083437061046;4275.123599662093;4341.4790225172865;4510.345999830006;328519;329663;329999;330637;331244.343778282;35111.64888351084;35738.28523429517;60728.392716073155;61494.69252653708;61626.38373616206;36698.26603467969;36814.63185368112;36833.81583092121;36874.63125368766;36882.8155859219;14447.78328325076;14615.050021748551;14618;14627.853721462649;14633;12253.632391028283;12318.076144289214;12327.568535101229;12338.259704417764;12344.876551234373;8562.61468233931;8570.614322355508;8576;8588.484690918565;8642.524661143572;3263.592050993626;3275.2303208745925;3300.1914530939594;3300.85146168423;3356.3958487472;1003.964861229868;1013.8276492996208;1024.109025148111;1061.6178175856685;1105.2146398584814;29861.55207671887;31082.378352432825;31221.687783121877;31369.686303137132;31694;1084.4469320646526;1088.6951653537021;1121.8373335866254;1179.0331927819277;1182.9822552661717;15655.452059178102;16778.832211677727;17363.65272694539;17378.3048678054;17380;475023;481713;483710;485710;487029;59934.400655993755;60803;60908;60942;60978.39021609727;1262.5391732017931;1369.9041067125206;1414.2433797918065;1423.2954687429788;1474.5576327101826;30656.08031759051;31644.683553165094;32322.35355292928;32545.837270813496;32546.83726581352;47774.76112619415;48916.510834891196;48981;48989;49137.754311228215;430568;448234;448281;448593;448952;34485.82757086299;39410;39411.40882886702;39500.604993949695;40476.3928541078;45097;45146.322805157295;45548.77225613983;45713.77143114263;46480.302795458774;38391;39258;39277.60722392739;39364.60635393609;41451.37822932598;40994.79502602587;41178.1764364705;41189.58810411858;41994;42045.57954420416;38141;39044.6095539041;42384.78807605942;42602.78698606487;42864;32469;33909.66090339065;34030.149246269044;34369.48445773265;34636.307273853876;25766.742332577185;27993.860030700533;28074.57888131639;28125.71874281313;28155 22:25:31 INFO - PROCESS | 5938 | |2;jquery.html;383.5110234451075;386.36250187191115;390.51249884066635;396.6133020305202;398.62927477445965;14476.855231447682;15206.391744330242;18016.819831801677;18473.815261847376;18552.165152568134;14561.344739486722;17724.822751772477;17751.82248177518;18480.815191848076;18732.53168670784;5440.782368705247;5540.2243685884005;5625.5499560035305;5629.549636029128;5635.126555383922;4071.87784366468;4250.001249706316;5353.892922141555;5522.199281104237;5539.972300138494;4236.089240813225;5960.225170727799;6250.4999600032115;6273.654948977827;6276.843078923018;6184.876302473948;6237.126802247689;6248.0627905814035;6254.093156492283;6256.343083976185;5404.189371594253;5561.833145005616;5574.86062848428;5579.581531385122;5600.691961942091;21096.789032109635;21371.252006179708;22193.667094993587;22328.995195216256;22570.88714556433;2430.1858877276136;2717.3070866929006;2737.9589306160424;3127.4839651457482;3134.670859559759;13514.932425337909;13979.37092830825;14123.505677301246;14528.564143075724;14600.342984565614;1830.9859154929604;1900.353879680915;1921.2123029557815;1967.252444071258;2016.25398602518;71201.64399178023;74534.62732686411;75137.62431187864;84077.57961210154;87612;10000.649977250761;10386.792264154674;10447.216458765472;10576;10701.732456688645;14736.263186840615;14784;14857.925710371379;14871.107733536022;14886;7099.964500177466;7637.885431718529;7892.644830982619;8002.159773223728;9390.953045234866;8167.63245653947;8265.8346833063;8401.495910245283;8517.105703901125;8687.782805429915;8338.874916876252;8341.708040218564;8372.194550830467;8710.43382180169;8891.244244239182;3127.749780017639;3182.7428165874812;3248.805071695706;3292.588426446694;3354.1614596350914;919.7010971434311;951.1392190068;979.6865003198908;996.9601215951426;1008.8890222075565;17384;17743.201555930013;18224.726629100573;18742.65834237263;19880;980.8690817754882;1025.1183981775666;1037.092544023979;1059.7138772531373;1064.2869277584036;10374;10464.52909619069;10470.214733894836;10505.9474702626;10558.577656893638;383391;383431;385670;388370;463801;90164;90491.54754226186;99403;99526;106094.46952765186;1032.6850310655323;1064.3028816125604;1070.2722148938797;1070.9732256693644;1074.5594306334365;16736.246868890685;16749.581260468585;17012.31950722007;17106;17395;39430.408543872436;39923.201535969696;40009.1998160041;40099.99750006273;40522.59477405306;54300.728496358846;55505.444945551644;55704.16443753266;55969.16046259228;56285;8546.572671366532;8593.828123437372;8608.655653774029;8611;8749.518776467356;10402.323848949794;10834.566617335218;12021.519139234333;12665.113442058968;13109.016823738068;10268.794624107626;11679.240849344766;11722.296662200295;11758;12341.938290308492;9035.954820225857;11373.658790236306;11670.124740644655;11859.762804744028;11860.881391186324;11850.288982661068;12080.939595301967;12094.75810483803;12126;12261.325627090238;8193.09875913661;8518.190771876662;8601.096884827253;8859.025507194074;8863.734087977371;10247.897521024694;11159.330440173615;11203;11319.773604527698;11390 22:25:31 INFO - PROCESS | 5938 | |3;mootools.html;1338.2438922009057;1469.537095814818;1490.4410845932773;1627.8534931856138;1753.1760072765796;7997.120316765158;8326.084130745621;8361.790955226115;8362.372822038342;8375.91624083759;8072.677092916291;8259.256666899977;8259.834803303931;8273.214044665761;8282;2039.51051747581;2098.5383215692523;2225.0765932138142;2257.379220714304;2275.943101422461;2257.160414262371;2258.1870526610487;2258.898349574273;2261.7398999115067;2263.6151854184827;2217.246136313653;2225.299030805299;2277.191596983072;2280.646499792535;2281.167373908528;2009.7688765791975;2075.7820428855057;2216.9556608867892;2220.7779222077825;2283.7145356830397;2227.6324406472913;2231.553689262154;2249.718785151856;2249.966250506244;2250.6624006399006;8180;8247.546384948826;8255.628496717662;8264.049634292012;8273.710420135267;4958.826441074545;5114.488551144893;5118.692878427306;5136.255242989783;5166.276721258989;3081.0910781319562;3169.3027533942495;3265.5428240046413;3292.8353582320788;3314.66853314669;951.8905325887542;982.7592239901198;983.311681822727;1000.9649662261859;1004.1163775877254;11864.347460889647;11910.46402911871;11915;11941.64175074749;11949.283043017447;4497;4546.340780586796;4576.565226303496;4595.839145629887;4669;10172.338797978107;10202.030807073315;10211.438370889673;10216.080552750289;10216.438095904796;5157.381114266312;5175.45657705943;5203.843884683465;5206.219067139959;5206.479352064839;4338.392625032498;4645.605123564535;4716;4759.428868535798;4775.42694876617;3852.7303088783515;3882.4370466282794;3911.6088391161225;3938.8818335449982;4008.8596899108393;1275.853276873153;1289.2006955687534;1290.6321698315935;1296.5138073222543;1312.7637025335341;830.8712149616819;840.1220724343076;849.163573879728;865.0959747064333;867.5011868175824;5479.698616576126;5823.417658234142;5885.882282354414;5932.766642180022;5962.314333851663;915.208344781759;947.8246524392871;958.750724811554;973.2700474644017;985.4136788610765;3893.8053097345587;3919.1573811630637;3936.291467535871;3971.5035620547433;3989.860354887623;10431.739206519898;10758.193135514868;10800.51397687106;10961.287516311415;10979.451027448755;10728.195385346131;10787.78424431507;10790.622328218475;10818.67543973682;10831.07935825448;7778.455508114491;7820.257075577811;8152.3478121751305;8261.339092872557;8273.379496537784;5571.0807716726285;5590.357108932362;5631.465010823965;5674.290713660793;5699.544036476989;9198.540072996457;9531.189848862925;9666;9811.901880981384;9837.114659680663;9340;9643.758906027406;9736.61053557878;9812.55843487059;9876.604935802774;6529.542931994904;7386.556806591621;7483.925160748323;7581.810454738676;7683.346915512244;8235.423520353757;8249.340052795642;8298.460600060977;8304.626291817003;8322.70870519529;7222.133343998544;7352.632368381666;7516.924830751841;7609.619519024137;7693.769186924401;7070.1869285030825;7172.354488096096;7239.710411583477;7249.130104387507;7258.818529536593;6658.533902626769;6741.2921643226755;6751.122354093936;6757.966210169115;6764.154480689914;4921.138800709933;5008.77460514285;5127.3847138343635;5128.9487105129965;5175.223716442564;5100.285959965682;5136.5377116059735;5177.844664660066;5179.611529135405;5261.500157485033 22:25:31 INFO - PROCESS | 5938 | |4;prototype.html;313.3638713411775;325.5507399788292;328.1811879360995;328.5580893697977;331.39520375315055;5096.898062038757;5138.100832354342;5202.791888324467;5267.789288428463;5288.89422211556;5188.636795424312;5224.50367215114;5233.142234506752;5242.9213561796605;5248;4053.716239863196;4076.408920706496;4091.509018917734;4102.487189101363;4147.357159640261;3852.614738526139;3888.0279930017496;4057.797110144496;4085.2646523625735;4104.712670113078;3994.8801535953967;4017.6785857131504;4042.3128068228325;4054.067564460176;4055.3105971984687;3996.760194388346;4010.4585880905997;4011.65900898424;4012.7993600320015;4029.2344454553836;3460.567429071366;3524.9118772030647;3528.400171970771;3536;3536.6993805526563;4943.431505376891;5002.374703162105;5003.674761140551;5011.173156429185;5038.84883453497;4626.421697287839;4658.95341046592;4670.789814458358;4679.578837904571;4679.906401871977;5299.33758280215;5403.78384864605;5434.429384914606;5437.945620543823;5441.727913604304;3947.2500224957453;3960.980195099035;3961.4057891316247;3970.325044742372;3985.7608543487486;5632;5634.267545219095;5658.943410565883;5666.676662568328;5670.4896559309445;4019.437278780973;4036.273470775289;4036.313826649418;4078.1232035112594;4079.8776036718946;4009.8797036088963;4101.753894766323;4108.198901214235;4122.628963393309;4164.500259968823;4663.183942809995;4676.789544470439;4705.55297246761;4706.552877476634;4717.834875779331;5274.551663108602;5489.368722596872;5489.451054894478;5536.972315138399;5537.972310138504;1417.4117741137518;1500.3848422147087;1504.3982407037272;1512.10785636475;1515.727169109571;1017.4658304390107;1033.4161198922584;1045.4459136657583;1045.9163266938626;1050.9054185123375;5622.493975542221;5625.296837895263;5629.802956896489;5642.633228840113;5646.2377579027125;5979.611325263931;5981.700914954235;5985.760569577255;5989.64062156272;6001.849953751103;5498.917516237259;5568.860778480571;5572.777088916398;5594.860128496739;5627.352854421712;3142.292984078564;3165.2561648012697;3172.032530078302;3182.7772055956325;3186.85659145339;5927.318358388754;6145.84635384119;6147.170132032208;6152.938470615326;6175.197224360804;6033.849153771191;6063.666498342545;6093.238345206849;6100.267967843887;6110.114033465123;6099.817005489843;6125.908111378333;6127.724252408563;6137.202163718688;6141;5787.276590426197;5902.291724993029;5926.911096333644;5934.495567876606;5955.851103722268;5866.442687944638;5870.295564532284;5884.558658100574;5898.4101589842385;5923.940760592339;5958.225430693982;6129.570930034854;6154.661493617894;6164.537659675632;6167.290761562478;4233.322668373045;4256.276433006458;4272.060146767706;4273.337632666941;4290.12052529237;5395.78416863321;5407.72961351923;5947.48339173508;5971.462568368867;5972.820815375546;5495.835124946258;5578.832635020955;5581.469760372758;5592.440755924375;5602.1036634138345;5414.35027796667;5470.945290547043;5491.341039075336;5509.256250406304;5520.199571062093;5197.648611360998;5444.482774136609;5459.617826752089;5464.535514481314;5488.670679759227;5549.306336707911;5563.193336966036;5579.553635709215;5591.30108736408;5608.691521966331;5199;5398.325209348832;5422.403535611158;5446.591505637172;5464.3442786865835 22:25:31 INFO - PROCESS | 5938 | |5;yui.html;808.5795386399071;840.4831028917214;850.2942557677129;852.7143406958669;855.3841234311294;14055;14267.215303158322;14377.78433323501;14509.854901450983;14606.634834129152;13437.596872093829;13851.861481385184;13861.653458663539;13878.861211387883;13911.513097041605;679.0628932073731;787.5629025890628;807.1041144329804;811.1037303779298;816.7508909782514;812.5652775764967;813.4062134641715;814.6171299489231;814.9429539932207;815.355868863597;853.4793775796759;855.5807654249404;855.6406309350057;855.9786005349854;855.9914400856005;697.2295613347254;713.5362014690467;715.1275443958363;824.431142511671;843.2874221283037;615.7136931326954;616.8365383173418;617.4813156948185;617.6016469377272;617.9258488981351;14198.432062717478;14209.857901420957;14212.147271163763;14224.644383890485;14299.428022879176;13377.197368157942;13955.58133256004;13980.930095349458;14085.71828563423;14125.223112728796;11282.435878206139;11509.712257193638;11625.59310424131;11767.7058073548;11921.463534140985;3829.5978922213326;3846.961530384688;3900.941485877714;3930.0960779020984;3980.9402858957137;58225.70887145537;58299.70850145722;58329.125063124084;58786.41213587895;59173.40826591722;10573.259871809054;10646.840297395545;10746.94626526878;10842.457877106113;10871.130309575216;18954.526136846413;18991.81008189928;19028.526291582006;19069.332573360145;19184.808151918303;8100.959495202486;8282.337413006944;8413.368997325226;8473.830523389497;8568;4719.669623126417;4761.857144285677;4771.5228477152705;4877.878053048702;4896.877578060577;3305.8512366943546;3355.8489867956;3384.0355498682757;3384.086296699877;3387.3733359328603;602.9577929544978;611.9541034422436;614.950803935693;623.9344868788803;625.2996643758928;701.3442431326725;713.3365969648173;741.7663436017638;761.9580923049285;768.4275214964775;9421.340506164639;9816.803663926681;9833.26250531213;9892.109710126124;9913.256505762096;648.9123968264319;657.5594351784316;706.2795948132875;743.7211045857804;744.2148533297315;4285.721428107163;4513.413256276663;4543.795529201194;4560.315952607069;4563.543645635476;65347.34652653413;66026.66986665037;68013.65993170002;68095;69324.6533767338;58752;59009;60360.396396035474;60671;61501.38498614957;52541.7372913133;53076.73461632667;53502.197467037244;53913.73043134759;54288.72855635697;8444.324454043539;8634.179752923463;8734.956325218332;8778.473291602524;8971.192592666692;35362;36319.63680363163;36772;37159;37438.438423423126;47127;47555.52444475649;48137.27794083161;48499.51500485091;48908.51091489182;10976.12191024732;11160.665180044612;11413.657590272305;11572.18994670365;11580.768384632429;12760.170588911691;12846.743065138831;12930.224186548838;12931.159474634118;12985.48058077704;12069.818952715892;12076.818847717466;12140.150189487005;12299.385030748606;12434.191777534432;13294.135881167693;13703.931480342535;13726.588202353945;13977.091489053179;14135;13264.53574124901;13449.327533623475;13701.794473082713;13753.312334383041;14017.789733153806;10450.68647940563;10543.736406589896;10557.102646275152;10914.30541468247;11476.196666233618;10626.681199564026;10690.62582809598;10749.193810464403;10848.891511085103;11003.834942475709 22:25:31 INFO - PROCESS | 5938 | __end_tp_report 22:25:31 INFO - PROCESS | 5938 | __start_cc_report 22:25:31 INFO - PROCESS | 5938 | _x_x_mozilla_cycle_collect,810 22:25:31 INFO - PROCESS | 5938 | __end_cc_report 22:25:31 INFO - PROCESS | 5938 | __startTimestamp1461648331585__endTimestamp 22:25:31 INFO - PROCESS | 5938 | 22:25:31 INFO - PROCESS | 5938 | ------- Summary: start ------- 22:25:31 INFO - PROCESS | 5938 | Number of tests: 6 22:25:31 INFO - PROCESS | 5938 | 22:25:31 INFO - PROCESS | 5938 | [#0] dojo.html Cycles:165 Average:5227.12 Median:5466.97 stddev:578.79 (10.6%) stddev-sans-first:555.13 22:25:31 INFO - PROCESS | 5938 | Values: 3063.8 3107.7 3132.7 3146.4 3178.3 5188.1 5269.6 5275.3 5287.0 5313.3 5205.8 5240.8 5293.6 5381.8 5405.3 4790.1 4792.0 4824.2 4837.2 4978.2 4884.1 4896.3 4929.7 4937.2 4965.3 4737.1 4745.2 4807.3 4890.3 4904.8 4763.9 4768.0 4774.4 4785.5 4827.0 4712.1 4714.0 4749.6 4753.3 4803.6 5070.2 5196.1 5272.8 5302.6 5322.4 5512.2 5554.7 5565.9 5590.7 5593.0 5597.5 5630.5 5631.0 5635.6 5649.5 5249.0 5259.1 5278.4 5313.9 5324.2 5763.0 5778.2 5782.4 5787.6 5830.7 5458.8 5520.1 5536.6 5540.4 5546.3 5537.1 5541.1 5541.3 5566.2 5592.1 5524.0 5526.9 5528.2 5528.7 5535.3 5473.0 5518.6 5552.7 5597.2 5600.9 4246.7 4251.0 4258.9 4291.4 4292.5 3815.5 3822.7 3825.3 3849.9 3863.3 5106.7 5190.8 5297.5 5315.1 5451.0 5578.9 5589.7 5604.6 5605.0 5612.0 5257.3 5265.4 5273.0 5282.0 5347.8 4747.6 4825.4 4838.2 4901.2 4916.4 5725.5 5741.6 5747.5 5751.1 5751.3 5576.6 5581.9 5581.9 5611.2 5631.1 5827.4 5869.0 5873.1 5913.3 5923.3 5563.3 5581.2 5582.5 5585.6 5620.2 5589.5 5652.2 5691.3 5717.7 5726.2 5391.3 5544.8 5545.3 5548.4 5596.2 5487.7 5512.9 5513.2 5519.1 5528.0 5213.3 5305.3 5390.4 5436.2 5467.0 5555.7 5576.1 5579.2 5580.4 5581.9 5419.9 5468.5 5476.2 5482.2 5500.4 22:25:31 INFO - PROCESS | 5938 | 22:25:31 INFO - PROCESS | 5938 | [#1] ext.html Cycles:180 Average:57011.27 Median:20977.02 stddev:112427.64 (536.0%) stddev-sans-first:112663.25 22:25:31 INFO - PROCESS | 5938 | Values: 599.4 646.1 649.0 654.7 658.8 31612.7 32366.2 38816.2 39624.8 39760.6 42254.8 42920.1 42982.4 43086.0 43089.0 8502.8 8687.2 8693.9 8701.3 8701.6 7575.3 7847.5 9860.9 10125.7 10133.4 10184.8 10341.9 10342.5 10342.6 10345.4 7683.7 7884.6 10259.3 10417.4 10433.4 9908.0 10119.1 10147.0 10147.5 10150.8 39156.2 39588.6 39790.6 39880.4 40043.4 3674.3 3813.0 3885.7 4055.5 4196.8 30599.7 32375.4 32375.9 32847.5 32894.0 3905.1 4263.1 4275.1 4341.5 4510.3 328519.0 329663.0 329999.0 330637.0 331244.3 35111.6 35738.3 60728.4 61494.7 61626.4 36698.3 36814.6 36833.8 36874.6 36882.8 14447.8 14615.1 14618.0 14627.9 14633.0 12253.6 12318.1 12327.6 12338.3 12344.9 8562.6 8570.6 8576.0 8588.5 8642.5 3263.6 3275.2 3300.2 3300.9 3356.4 1004.0 1013.8 1024.1 1061.6 1105.2 29861.6 31082.4 31221.7 31369.7 31694.0 1084.4 1088.7 1121.8 1179.0 1183.0 15655.5 16778.8 17363.7 17378.3 17380.0 475023.0 481713.0 483710.0 485710.0 487029.0 59934.4 60803.0 60908.0 60942.0 60978.4 1262.5 1369.9 1414.2 1423.3 1474.6 30656.1 31644.7 32322.4 32545.8 32546.8 47774.8 48916.5 48981.0 48989.0 49137.8 430568.0 448234.0 448281.0 448593.0 448952.0 34485.8 39410.0 39411.4 39500.6 40476.4 45097.0 45146.3 45548.8 45713.8 46480.3 38391.0 39258.0 39277.6 39364.6 41451.4 40994.8 41178.2 41189.6 41994.0 42045.6 38141.0 39044.6 42384.8 42602.8 42864.0 32469.0 33909.7 34030.1 34369.5 34636.3 25766.7 27993.9 28074.6 28125.7 28155.0 22:25:31 INFO - PROCESS | 5938 | 22:25:31 INFO - PROCESS | 5938 | [#2] jquery.html Cycles:180 Average:26475.14 Median:3158.71 stddev:66940.66 (2119.2%) stddev-sans-first:67099.78 22:25:31 INFO - PROCESS | 5938 | Values: 383.5 386.4 390.5 396.6 398.6 14476.9 15206.4 18016.8 18473.8 18552.2 14561.3 17724.8 17751.8 18480.8 18732.5 5440.8 5540.2 5625.5 5629.5 5635.1 4071.9 4250.0 5353.9 5522.2 5540.0 4236.1 5960.2 6250.5 6273.7 6276.8 6184.9 6237.1 6248.1 6254.1 6256.3 5404.2 5561.8 5574.9 5579.6 5600.7 21096.8 21371.3 22193.7 22329.0 22570.9 2430.2 2717.3 2738.0 3127.5 3134.7 13514.9 13979.4 14123.5 14528.6 14600.3 1831.0 1900.4 1921.2 1967.3 2016.3 71201.6 74534.6 75137.6 84077.6 87612.0 10000.6 10386.8 10447.2 10576.0 10701.7 14736.3 14784.0 14857.9 14871.1 14886.0 7100.0 7637.9 7892.6 8002.2 9391.0 8167.6 8265.8 8401.5 8517.1 8687.8 8338.9 8341.7 8372.2 8710.4 8891.2 3127.7 3182.7 3248.8 3292.6 3354.2 919.7 951.1 979.7 997.0 1008.9 17384.0 17743.2 18224.7 18742.7 19880.0 980.9 1025.1 1037.1 1059.7 1064.3 10374.0 10464.5 10470.2 10505.9 10558.6 383391.0 383431.0 385670.0 388370.0 463801.0 90164.0 90491.5 99403.0 99526.0 106094.5 1032.7 1064.3 1070.3 1071.0 1074.6 16736.2 16749.6 17012.3 17106.0 17395.0 39430.4 39923.2 40009.2 40100.0 40522.6 54300.7 55505.4 55704.2 55969.2 56285.0 8546.6 8593.8 8608.7 8611.0 8749.5 10402.3 10834.6 12021.5 12665.1 13109.0 10268.8 11679.2 11722.3 11758.0 12341.9 9036.0 11373.7 11670.1 11859.8 11860.9 11850.3 12080.9 12094.8 12126.0 12261.3 8193.1 8518.2 8601.1 8859.0 8863.7 10247.9 11159.3 11203.0 11319.8 11390.0 22:25:31 INFO - PROCESS | 5938 | 22:25:31 INFO - PROCESS | 5938 | [#3] mootools.html Cycles:180 Average:5606.70 Median:5136.40 stddev:3191.57 (62.1%) stddev-sans-first:3184.40 22:25:31 INFO - PROCESS | 5938 | Values: 1338.2 1469.5 1490.4 1627.9 1753.2 7997.1 8326.1 8361.8 8362.4 8375.9 8072.7 8259.3 8259.8 8273.2 8282.0 2039.5 2098.5 2225.1 2257.4 2275.9 2257.2 2258.2 2258.9 2261.7 2263.6 2217.2 2225.3 2277.2 2280.6 2281.2 2009.8 2075.8 2217.0 2220.8 2283.7 2227.6 2231.6 2249.7 2250.0 2250.7 8180.0 8247.5 8255.6 8264.0 8273.7 4958.8 5114.5 5118.7 5136.3 5166.3 3081.1 3169.3 3265.5 3292.8 3314.7 951.9 982.8 983.3 1001.0 1004.1 11864.3 11910.5 11915.0 11941.6 11949.3 4497.0 4546.3 4576.6 4595.8 4669.0 10172.3 10202.0 10211.4 10216.1 10216.4 5157.4 5175.5 5203.8 5206.2 5206.5 4338.4 4645.6 4716.0 4759.4 4775.4 3852.7 3882.4 3911.6 3938.9 4008.9 1275.9 1289.2 1290.6 1296.5 1312.8 830.9 840.1 849.2 865.1 867.5 5479.7 5823.4 5885.9 5932.8 5962.3 915.2 947.8 958.8 973.3 985.4 3893.8 3919.2 3936.3 3971.5 3989.9 10431.7 10758.2 10800.5 10961.3 10979.5 10728.2 10787.8 10790.6 10818.7 10831.1 7778.5 7820.3 8152.3 8261.3 8273.4 5571.1 5590.4 5631.5 5674.3 5699.5 9198.5 9531.2 9666.0 9811.9 9837.1 9340.0 9643.8 9736.6 9812.6 9876.6 6529.5 7386.6 7483.9 7581.8 7683.3 8235.4 8249.3 8298.5 8304.6 8322.7 7222.1 7352.6 7516.9 7609.6 7693.8 7070.2 7172.4 7239.7 7249.1 7258.8 6658.5 6741.3 6751.1 6758.0 6764.2 4921.1 5008.8 5127.4 5128.9 5175.2 5100.3 5136.5 5177.8 5179.6 5261.5 22:25:31 INFO - PROCESS | 5938 | 22:25:31 INFO - PROCESS | 5938 | [#4] prototype.html Cycles:180 Average:4720.71 Median:5271.17 stddev:1407.26 (26.7%) stddev-sans-first:1371.78 22:25:31 INFO - PROCESS | 5938 | Values: 313.4 325.6 328.2 328.6 331.4 5096.9 5138.1 5202.8 5267.8 5288.9 5188.6 5224.5 5233.1 5242.9 5248.0 4053.7 4076.4 4091.5 4102.5 4147.4 3852.6 3888.0 4057.8 4085.3 4104.7 3994.9 4017.7 4042.3 4054.1 4055.3 3996.8 4010.5 4011.7 4012.8 4029.2 3460.6 3524.9 3528.4 3536.0 3536.7 4943.4 5002.4 5003.7 5011.2 5038.8 4626.4 4659.0 4670.8 4679.6 4679.9 5299.3 5403.8 5434.4 5437.9 5441.7 3947.3 3961.0 3961.4 3970.3 3985.8 5632.0 5634.3 5658.9 5666.7 5670.5 4019.4 4036.3 4036.3 4078.1 4079.9 4009.9 4101.8 4108.2 4122.6 4164.5 4663.2 4676.8 4705.6 4706.6 4717.8 5274.6 5489.4 5489.5 5537.0 5538.0 1417.4 1500.4 1504.4 1512.1 1515.7 1017.5 1033.4 1045.4 1045.9 1050.9 5622.5 5625.3 5629.8 5642.6 5646.2 5979.6 5981.7 5985.8 5989.6 6001.8 5498.9 5568.9 5572.8 5594.9 5627.4 3142.3 3165.3 3172.0 3182.8 3186.9 5927.3 6145.8 6147.2 6152.9 6175.2 6033.8 6063.7 6093.2 6100.3 6110.1 6099.8 6125.9 6127.7 6137.2 6141.0 5787.3 5902.3 5926.9 5934.5 5955.9 5866.4 5870.3 5884.6 5898.4 5923.9 5958.2 6129.6 6154.7 6164.5 6167.3 4233.3 4256.3 4272.1 4273.3 4290.1 5395.8 5407.7 5947.5 5971.5 5972.8 5495.8 5578.8 5581.5 5592.4 5602.1 5414.4 5470.9 5491.3 5509.3 5520.2 5197.6 5444.5 5459.6 5464.5 5488.7 5549.3 5563.2 5579.6 5591.3 5608.7 5199.0 5398.3 5422.4 5446.6 5464.3 22:25:31 INFO - PROCESS | 5938 | 22:25:31 INFO - PROCESS | 5938 | [#5] yui.html Cycles:180 Average:15481.69 Median:25923.33 stddev:18484.28 (71.3%) stddev-sans-first:18503.30 22:25:31 INFO - PROCESS | 5938 | Values: 808.6 840.5 850.3 852.7 855.4 14055.0 14267.2 14377.8 14509.9 14606.6 13437.6 13851.9 13861.7 13878.9 13911.5 679.1 787.6 807.1 811.1 816.8 812.6 813.4 814.6 814.9 815.4 853.5 855.6 855.6 856.0 856.0 697.2 713.5 715.1 824.4 843.3 615.7 616.8 617.5 617.6 617.9 14198.4 14209.9 14212.1 14224.6 14299.4 13377.2 13955.6 13980.9 14085.7 14125.2 11282.4 11509.7 11625.6 11767.7 11921.5 3829.6 3847.0 3900.9 3930.1 3980.9 58225.7 58299.7 58329.1 58786.4 59173.4 10573.3 10646.8 10746.9 10842.5 10871.1 18954.5 18991.8 19028.5 19069.3 19184.8 8101.0 8282.3 8413.4 8473.8 8568.0 4719.7 4761.9 4771.5 4877.9 4896.9 3305.9 3355.8 3384.0 3384.1 3387.4 603.0 612.0 615.0 623.9 625.3 701.3 713.3 741.8 762.0 768.4 9421.3 9816.8 9833.3 9892.1 9913.3 648.9 657.6 706.3 743.7 744.2 4285.7 4513.4 4543.8 4560.3 4563.5 65347.3 66026.7 68013.7 68095.0 69324.7 58752.0 59009.0 60360.4 60671.0 61501.4 52541.7 53076.7 53502.2 53913.7 54288.7 8444.3 8634.2 8735.0 8778.5 8971.2 35362.0 36319.6 36772.0 37159.0 37438.4 47127.0 47555.5 48137.3 48499.5 48908.5 10976.1 11160.7 11413.7 11572.2 11580.8 12760.2 12846.7 12930.2 12931.2 12985.5 12069.8 12076.8 12140.2 12299.4 12434.2 13294.1 13703.9 13726.6 13977.1 14135.0 13264.5 13449.3 13701.8 13753.3 14017.8 10450.7 10543.7 10557.1 10914.3 11476.2 10626.7 10690.6 10749.2 10848.9 11003.8 22:25:31 INFO - PROCESS | 5938 | -------- Summary: end -------- 22:25:31 INFO - PROCESS | 5938 | 22:25:32 INFO - TEST-INFO | 5938: exit 0 22:25:32 INFO - TEST-OK | dromaeo_css | took 1112211ms 22:25:32 INFO - TEST-START | kraken 22:25:32 INFO - operating with platform_type : linux_ 22:25:32 INFO - Initialising browser for kraken test... 22:25:32 INFO - TEST-INFO | started process 6126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDmb4ne/profile http://localhost:57341/getInfo.html) 22:25:36 INFO - PROCESS | 6126 | __metrics Screen width/height:1600/1200 22:25:36 INFO - PROCESS | 6126 | colorDepth:24 22:25:36 INFO - PROCESS | 6126 | Browser inner width/height: 1024/697 22:25:36 INFO - PROCESS | 6126 | __metrics 22:25:37 ERROR - PROCESS | 6126 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:25:37 INFO - TEST-INFO | 6126: exit 0 22:25:37 INFO - Browser initialized. 22:25:37 INFO - Running cycle 1/1 for kraken test... 22:25:37 INFO - TEST-INFO | started process 6206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDmb4ne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:25:49 INFO - PROCESS | 6206 | RSS: Main: 154398720 22:25:49 INFO - PROCESS | 6206 | 22:25:52 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57341/tests/kraken/driver.html?testName=audio-beat-detection) 22:25:52 INFO - PROCESS | 6206 | RSS: Main: 210227200 22:25:52 INFO - PROCESS | 6206 | 22:25:55 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57341/tests/kraken/driver.html?testName=audio-dft) 22:25:56 INFO - PROCESS | 6206 | RSS: Main: 195567616 22:25:56 INFO - PROCESS | 6206 | 22:25:59 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57341/tests/kraken/driver.html?testName=audio-fft) 22:26:00 INFO - PROCESS | 6206 | RSS: Main: 264781824 22:26:00 INFO - PROCESS | 6206 | 22:26:02 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57341/tests/kraken/driver.html?testName=audio-oscillator) 22:26:02 INFO - PROCESS | 6206 | RSS: Main: 173539328 22:26:02 INFO - PROCESS | 6206 | 22:26:04 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57341/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:26:05 INFO - PROCESS | 6206 | RSS: Main: 177467392 22:26:05 INFO - PROCESS | 6206 | 22:26:08 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57341/tests/kraken/driver.html?testName=imaging-darkroom) 22:26:09 INFO - PROCESS | 6206 | RSS: Main: 214695936 22:26:09 INFO - PROCESS | 6206 | 22:26:12 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57341/tests/kraken/driver.html?testName=imaging-desaturate) 22:26:13 INFO - PROCESS | 6206 | RSS: Main: 215121920 22:26:13 INFO - PROCESS | 6206 | 22:26:15 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57341/tests/kraken/driver.html?testName=json-parse-financial) 22:26:16 INFO - PROCESS | 6206 | RSS: Main: 215322624 22:26:16 INFO - PROCESS | 6206 | 22:26:17 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57341/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:26:18 INFO - PROCESS | 6206 | RSS: Main: 201465856 22:26:18 INFO - PROCESS | 6206 | 22:26:20 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57341/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:26:20 INFO - PROCESS | 6206 | RSS: Main: 204087296 22:26:20 INFO - PROCESS | 6206 | 22:26:22 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57341/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:26:23 INFO - PROCESS | 6206 | RSS: Main: 215506944 22:26:23 INFO - PROCESS | 6206 | 22:26:26 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:26:26 INFO - PROCESS | 6206 | RSS: Main: 224452608 22:26:26 INFO - PROCESS | 6206 | 22:26:29 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:26:30 INFO - PROCESS | 6206 | RSS: Main: 218361856 22:26:30 INFO - PROCESS | 6206 | 22:26:31 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:57341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57341/tests/kraken/driver.html?testName=ai-astar) 22:26:32 INFO - PROCESS | 6206 | RSS: Main: 282337280 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | __start_tp_report 22:26:32 INFO - PROCESS | 6206 | _x_x_mozilla_page_load 22:26:32 INFO - PROCESS | 6206 | _x_x_mozilla_page_load_details 22:26:32 INFO - PROCESS | 6206 | |i|pagename|runs| 22:26:32 INFO - PROCESS | 6206 | |0;ai-astar;109;110;105;111;111;110;99;109;109;109 22:26:32 INFO - PROCESS | 6206 | |1;audio-beat-detection;158;127;163;179;128;161;167;127;182;127 22:26:32 INFO - PROCESS | 6206 | |2;audio-dft;160;160;160;161;161;161;158;162;162;161 22:26:32 INFO - PROCESS | 6206 | |3;audio-fft;73;71;104;115;75;76;75;123;118;77 22:26:32 INFO - PROCESS | 6206 | |4;audio-oscillator;92;92;146;94;92;93;148;92;92;155 22:26:32 INFO - PROCESS | 6206 | |5;imaging-gaussian-blur;117;117;116;117;116;117;116;117;117;116 22:26:32 INFO - PROCESS | 6206 | |6;imaging-darkroom;145;145;145;146;145;145;145;145;145;145 22:26:32 INFO - PROCESS | 6206 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;94;94 22:26:32 INFO - PROCESS | 6206 | |8;json-parse-financial;57;57;57;55;57;55;55;80;55;54 22:26:32 INFO - PROCESS | 6206 | |9;json-stringify-tinderbox;60;61;60;62;61;60;60;61;62;61 22:26:32 INFO - PROCESS | 6206 | |10;stanford-crypto-aes;84;75;76;76;77;76;75;84;76;79 22:26:32 INFO - PROCESS | 6206 | |11;stanford-crypto-ccm;129;129;122;119;122;121;128;122;161;133 22:26:32 INFO - PROCESS | 6206 | |12;stanford-crypto-pbkdf2;166;166;165;165;167;166;169;165;173;163 22:26:32 INFO - PROCESS | 6206 | |13;stanford-crypto-sha256-iterative;69;68;71;70;70;69;69;68;67;67 22:26:32 INFO - PROCESS | 6206 | __end_tp_report 22:26:32 INFO - PROCESS | 6206 | __start_cc_report 22:26:32 INFO - PROCESS | 6206 | _x_x_mozilla_cycle_collect,1645 22:26:32 INFO - PROCESS | 6206 | __end_cc_report 22:26:32 INFO - PROCESS | 6206 | __startTimestamp1461648392029__endTimestamp 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | ------- Summary: start ------- 22:26:32 INFO - PROCESS | 6206 | Number of tests: 14 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.65 (3.3%) stddev-sans-first:3.86 22:26:32 INFO - PROCESS | 6206 | Values: 109.0 110.0 105.0 111.0 111.0 110.0 99.0 109.0 109.0 109.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:162.00 stddev:22.47 (13.9%) stddev-sans-first:23.72 22:26:32 INFO - PROCESS | 6206 | Values: 158.0 127.0 163.0 179.0 128.0 161.0 167.0 127.0 182.0 127.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 22:26:32 INFO - PROCESS | 6206 | Values: 160.0 160.0 160.0 161.0 161.0 161.0 158.0 162.0 162.0 161.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#3] audio-fft Cycles:10 Average:90.70 Median:74.00 stddev:21.48 (29.0%) stddev-sans-first:21.81 22:26:32 INFO - PROCESS | 6206 | Values: 73.0 71.0 104.0 115.0 75.0 76.0 75.0 123.0 118.0 77.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.00 stddev:27.75 (30.2%) stddev-sans-first:28.69 22:26:32 INFO - PROCESS | 6206 | Values: 92.0 92.0 146.0 94.0 92.0 93.0 148.0 92.0 92.0 155.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:26:32 INFO - PROCESS | 6206 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 22:26:32 INFO - PROCESS | 6206 | Values: 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:26:32 INFO - PROCESS | 6206 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.00 stddev:7.74 (13.6%) stddev-sans-first:8.20 22:26:32 INFO - PROCESS | 6206 | Values: 57.0 57.0 57.0 55.0 57.0 55.0 55.0 80.0 55.0 54.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 22:26:32 INFO - PROCESS | 6206 | Values: 60.0 61.0 60.0 62.0 61.0 60.0 60.0 61.0 62.0 61.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:76.50 stddev:3.46 (4.5%) stddev-sans-first:2.85 22:26:32 INFO - PROCESS | 6206 | Values: 84.0 75.0 76.0 76.0 77.0 76.0 75.0 84.0 76.0 79.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.50 stddev:12.25 (9.5%) stddev-sans-first:12.99 22:26:32 INFO - PROCESS | 6206 | Values: 129.0 129.0 122.0 119.0 122.0 121.0 128.0 122.0 161.0 133.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.00 stddev:2.76 (1.7%) stddev-sans-first:2.92 22:26:32 INFO - PROCESS | 6206 | Values: 166.0 166.0 165.0 165.0 167.0 166.0 169.0 165.0 173.0 163.0 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - PROCESS | 6206 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.32 (1.9%) stddev-sans-first:1.39 22:26:32 INFO - PROCESS | 6206 | Values: 69.0 68.0 71.0 70.0 70.0 69.0 69.0 68.0 67.0 67.0 22:26:32 INFO - PROCESS | 6206 | -------- Summary: end -------- 22:26:32 INFO - PROCESS | 6206 | 22:26:32 INFO - TEST-INFO | 6206: exit 0 22:26:33 INFO - TEST-OK | kraken | took 60726ms 22:26:33 INFO - SUITE-END | took 1172s 22:26:33 INFO - Completed test suite (00:19:33) 22:26:33 INFO - javascript benchmark 22:26:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3063.8008529445583, 3107.673694262101, 3132.6554079051302, 3146.4493713600114, 3178.2848859006717, 5188.118019936611, 5269.5520880725135, 5275.28783614212, 5287.048331300364, 5313.335833020872, 5205.765740541675, 5240.816571420001, 5293.550048245894, 5381.81163659272, 5405.324334458192, 4790.137775200463, 4791.976040119804, 4824.204006338968, 4837.177679794426, 4978.153713868633, 4884.145274576953, 4896.31451596775, 4929.728864912428, 4937.1606826839525, 4965.255211718235, 4737.0525894821, 4745.193317136095, 4807.326974223612, 4890.315355850184, 4904.75476226189, 4763.928541071887, 4768.0, 4774.40319960005, 4785.497522760095, 4826.951730482685, 4712.128256272601, 4713.976430117862, 4749.64377671676, 4753.33453316536, 4803.639727020487, 5070.163423035195, 5196.0647083524955, 5272.815451459181, 5302.602304827154, 5322.4411436799355, 5512.173174023888, 5554.666719996772, 5565.9443405565835, 5590.692511911843, 5593.021221286259, 5597.468240517144, 5630.493255606974, 5631.042722737145, 5635.633683810539, 5649.519790817785, 5249.028929648028, 5259.105951988171, 5278.366596008504, 5313.9106483171245, 5324.1747529133045, 5763.0, 5778.16216648592, 5782.421757824184, 5787.623804452697, 5830.679312637761, 5458.808941687102, 5520.089185284463, 5536.584756143306, 5540.418256083134, 5546.278983732089, 5537.1140617501815, 5541.141123125922, 5541.33503979525, 5566.248556444828, 5592.133219351007, 5523.972380138073, 5526.889462210734, 5528.226048353234, 5528.668279903219, 5535.308086489189, 5472.972635136878, 5518.558515318765, 5552.666839989613, 5597.244372009808, 5600.943990560042, 4246.745195288231, 4251.043515209115, 4258.893527661771, 4291.356296555479, 4292.5492823253735, 3815.465834783133, 3822.6559609635265, 3825.2540754552597, 3849.8652547160714, 3863.343231650626, 5106.693598384109, 5190.844274671766, 5297.5232229099565, 5315.149576067888, 5451.018816612968, 5578.944210557924, 5589.74846131925, 5604.635698679573, 5605.047141985872, 5611.971940140274, 5257.290265814143, 5265.368155821326, 5273.0, 5281.996420680135, 5347.812826551052, 4747.643926705442, 4825.372701548777, 4838.153323168432, 4901.1913034349645, 4916.385451818523, 5725.456081672234, 5741.569382296345, 5747.540196784247, 5751.079827227707, 5751.309842818889, 5576.553875690016, 5581.860453488695, 5581.888362232651, 5611.214429979887, 5631.1271752878365, 5827.3881242470625, 5868.970655146697, 5873.148393483007, 5913.2608423947, 5923.259592550931, 5563.304586926634, 5581.190727344593, 5582.497575218087, 5585.553155747449, 5620.213170156099, 5589.496945274945, 5652.152177173457, 5691.3170419549915, 5717.685527296038, 5726.169705392778, 5391.272178255886, 5544.805931792368, 5545.279113715191, 5548.4174161712435, 5596.1605759136455, 5487.725613719218, 5512.889742205213, 5513.173024046265, 5519.144532597454, 5528.0, 5213.270142180022, 5305.336832895888, 5390.434004429635, 5436.211749296251, 5466.972665136808, 5555.749991250323, 5576.10782274834, 5579.246801681721, 5580.38615752275, 5581.860453488695, 5419.918701219406, 5468.48049435303, 5476.2333273342565, 5482.23248745184, 5500.3949565548555], "value": 5189.277243402195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.3556926304221, 646.0728854094375, 648.964900982932, 654.6988385342748, 658.8287045368203, 31612.683873161262, 32366.19084522888, 38816.22367552651, 39624.801875990655, 39760.60239397605, 42254.7887260564, 42920.14159716804, 42982.35526467105, 43086.0, 43089.0, 8502.829943401144, 8687.218150366465, 8693.913060869405, 8701.260392866614, 8701.608427620773, 7575.318221360077, 7847.450678452511, 9860.852087218698, 10125.746856328577, 10133.391996480197, 10184.847227291597, 10341.948290258539, 10342.534585943613, 10342.586296548128, 10345.379277243352, 7683.6926522939575, 7884.64519096642, 10259.281850270485, 10417.374957502574, 10433.373997560133, 9908.0, 10119.139873110795, 10147.0, 10147.543360548792, 10150.796984060351, 39156.21687566261, 39588.60411395878, 39790.60209397898, 39880.40179397311, 40043.399349009494, 3674.2835147146316, 3813.046738315421, 3885.708571857122, 4055.5336136344404, 4196.81114349855, 30599.69400306013, 32375.352492950246, 32375.86769806341, 32847.507287390705, 32894.0, 3905.1408690088133, 4263.083437061046, 4275.123599662093, 4341.4790225172865, 4510.345999830006, 328519.0, 329663.0, 329999.0, 330637.0, 331244.343778282, 35111.64888351084, 35738.28523429517, 60728.392716073155, 61494.69252653708, 61626.38373616206, 36698.26603467969, 36814.63185368112, 36833.81583092121, 36874.63125368766, 36882.8155859219, 14447.78328325076, 14615.050021748551, 14618.0, 14627.853721462649, 14633.0, 12253.632391028283, 12318.076144289214, 12327.568535101229, 12338.259704417764, 12344.876551234373, 8562.61468233931, 8570.614322355508, 8576.0, 8588.484690918565, 8642.524661143572, 3263.592050993626, 3275.2303208745925, 3300.1914530939594, 3300.85146168423, 3356.3958487472, 1003.964861229868, 1013.8276492996208, 1024.109025148111, 1061.6178175856685, 1105.2146398584814, 29861.55207671887, 31082.378352432825, 31221.687783121877, 31369.686303137132, 31694.0, 1084.4469320646526, 1088.6951653537021, 1121.8373335866254, 1179.0331927819277, 1182.9822552661717, 15655.452059178102, 16778.832211677727, 17363.65272694539, 17378.3048678054, 17380.0, 475023.0, 481713.0, 483710.0, 485710.0, 487029.0, 59934.400655993755, 60803.0, 60908.0, 60942.0, 60978.39021609727, 1262.5391732017931, 1369.9041067125206, 1414.2433797918065, 1423.2954687429788, 1474.5576327101826, 30656.08031759051, 31644.683553165094, 32322.35355292928, 32545.837270813496, 32546.83726581352, 47774.76112619415, 48916.510834891196, 48981.0, 48989.0, 49137.754311228215, 430568.0, 448234.0, 448281.0, 448593.0, 448952.0, 34485.82757086299, 39410.0, 39411.40882886702, 39500.604993949695, 40476.3928541078, 45097.0, 45146.322805157295, 45548.77225613983, 45713.77143114263, 46480.302795458774, 38391.0, 39258.0, 39277.60722392739, 39364.60635393609, 41451.37822932598, 40994.79502602587, 41178.1764364705, 41189.58810411858, 41994.0, 42045.57954420416, 38141.0, 39044.6095539041, 42384.78807605942, 42602.78698606487, 42864.0, 32469.0, 33909.66090339065, 34030.149246269044, 34369.48445773265, 34636.307273853876, 25766.742332577185, 27993.860030700533, 28074.57888131639, 28125.71874281313, 28155.0], "value": 18960.667496177175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.5110234451075, 386.36250187191115, 390.51249884066635, 396.6133020305202, 398.62927477445965, 14476.855231447682, 15206.391744330242, 18016.819831801677, 18473.815261847376, 18552.165152568134, 14561.344739486722, 17724.822751772477, 17751.82248177518, 18480.815191848076, 18732.53168670784, 5440.782368705247, 5540.2243685884005, 5625.5499560035305, 5629.549636029128, 5635.126555383922, 4071.87784366468, 4250.001249706316, 5353.892922141555, 5522.199281104237, 5539.972300138494, 4236.089240813225, 5960.225170727799, 6250.4999600032115, 6273.654948977827, 6276.843078923018, 6184.876302473948, 6237.126802247689, 6248.0627905814035, 6254.093156492283, 6256.343083976185, 5404.189371594253, 5561.833145005616, 5574.86062848428, 5579.581531385122, 5600.691961942091, 21096.789032109635, 21371.252006179708, 22193.667094993587, 22328.995195216256, 22570.88714556433, 2430.1858877276136, 2717.3070866929006, 2737.9589306160424, 3127.4839651457482, 3134.670859559759, 13514.932425337909, 13979.37092830825, 14123.505677301246, 14528.564143075724, 14600.342984565614, 1830.9859154929604, 1900.353879680915, 1921.2123029557815, 1967.252444071258, 2016.25398602518, 71201.64399178023, 74534.62732686411, 75137.62431187864, 84077.57961210154, 87612.0, 10000.649977250761, 10386.792264154674, 10447.216458765472, 10576.0, 10701.732456688645, 14736.263186840615, 14784.0, 14857.925710371379, 14871.107733536022, 14886.0, 7099.964500177466, 7637.885431718529, 7892.644830982619, 8002.159773223728, 9390.953045234866, 8167.63245653947, 8265.8346833063, 8401.495910245283, 8517.105703901125, 8687.782805429915, 8338.874916876252, 8341.708040218564, 8372.194550830467, 8710.43382180169, 8891.244244239182, 3127.749780017639, 3182.7428165874812, 3248.805071695706, 3292.588426446694, 3354.1614596350914, 919.7010971434311, 951.1392190068, 979.6865003198908, 996.9601215951426, 1008.8890222075565, 17384.0, 17743.201555930013, 18224.726629100573, 18742.65834237263, 19880.0, 980.8690817754882, 1025.1183981775666, 1037.092544023979, 1059.7138772531373, 1064.2869277584036, 10374.0, 10464.52909619069, 10470.214733894836, 10505.9474702626, 10558.577656893638, 383391.0, 383431.0, 385670.0, 388370.0, 463801.0, 90164.0, 90491.54754226186, 99403.0, 99526.0, 106094.46952765186, 1032.6850310655323, 1064.3028816125604, 1070.2722148938797, 1070.9732256693644, 1074.5594306334365, 16736.246868890685, 16749.581260468585, 17012.31950722007, 17106.0, 17395.0, 39430.408543872436, 39923.201535969696, 40009.1998160041, 40099.99750006273, 40522.59477405306, 54300.728496358846, 55505.444945551644, 55704.16443753266, 55969.16046259228, 56285.0, 8546.572671366532, 8593.828123437372, 8608.655653774029, 8611.0, 8749.518776467356, 10402.323848949794, 10834.566617335218, 12021.519139234333, 12665.113442058968, 13109.016823738068, 10268.794624107626, 11679.240849344766, 11722.296662200295, 11758.0, 12341.938290308492, 9035.954820225857, 11373.658790236306, 11670.124740644655, 11859.762804744028, 11860.881391186324, 11850.288982661068, 12080.939595301967, 12094.75810483803, 12126.0, 12261.325627090238, 8193.09875913661, 8518.190771876662, 8601.096884827253, 8859.025507194074, 8863.734087977371, 10247.897521024694, 11159.330440173615, 11203.0, 11319.773604527698, 11390.0], "value": 9410.173704722813, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.2438922009057, 1469.537095814818, 1490.4410845932773, 1627.8534931856138, 1753.1760072765796, 7997.120316765158, 8326.084130745621, 8361.790955226115, 8362.372822038342, 8375.91624083759, 8072.677092916291, 8259.256666899977, 8259.834803303931, 8273.214044665761, 8282.0, 2039.51051747581, 2098.5383215692523, 2225.0765932138142, 2257.379220714304, 2275.943101422461, 2257.160414262371, 2258.1870526610487, 2258.898349574273, 2261.7398999115067, 2263.6151854184827, 2217.246136313653, 2225.299030805299, 2277.191596983072, 2280.646499792535, 2281.167373908528, 2009.7688765791975, 2075.7820428855057, 2216.9556608867892, 2220.7779222077825, 2283.7145356830397, 2227.6324406472913, 2231.553689262154, 2249.718785151856, 2249.966250506244, 2250.6624006399006, 8180.0, 8247.546384948826, 8255.628496717662, 8264.049634292012, 8273.710420135267, 4958.826441074545, 5114.488551144893, 5118.692878427306, 5136.255242989783, 5166.276721258989, 3081.0910781319562, 3169.3027533942495, 3265.5428240046413, 3292.8353582320788, 3314.66853314669, 951.8905325887542, 982.7592239901198, 983.311681822727, 1000.9649662261859, 1004.1163775877254, 11864.347460889647, 11910.46402911871, 11915.0, 11941.64175074749, 11949.283043017447, 4497.0, 4546.340780586796, 4576.565226303496, 4595.839145629887, 4669.0, 10172.338797978107, 10202.030807073315, 10211.438370889673, 10216.080552750289, 10216.438095904796, 5157.381114266312, 5175.45657705943, 5203.843884683465, 5206.219067139959, 5206.479352064839, 4338.392625032498, 4645.605123564535, 4716.0, 4759.428868535798, 4775.42694876617, 3852.7303088783515, 3882.4370466282794, 3911.6088391161225, 3938.8818335449982, 4008.8596899108393, 1275.853276873153, 1289.2006955687534, 1290.6321698315935, 1296.5138073222543, 1312.7637025335341, 830.8712149616819, 840.1220724343076, 849.163573879728, 865.0959747064333, 867.5011868175824, 5479.698616576126, 5823.417658234142, 5885.882282354414, 5932.766642180022, 5962.314333851663, 915.208344781759, 947.8246524392871, 958.750724811554, 973.2700474644017, 985.4136788610765, 3893.8053097345587, 3919.1573811630637, 3936.291467535871, 3971.5035620547433, 3989.860354887623, 10431.739206519898, 10758.193135514868, 10800.51397687106, 10961.287516311415, 10979.451027448755, 10728.195385346131, 10787.78424431507, 10790.622328218475, 10818.67543973682, 10831.07935825448, 7778.455508114491, 7820.257075577811, 8152.3478121751305, 8261.339092872557, 8273.379496537784, 5571.0807716726285, 5590.357108932362, 5631.465010823965, 5674.290713660793, 5699.544036476989, 9198.540072996457, 9531.189848862925, 9666.0, 9811.901880981384, 9837.114659680663, 9340.0, 9643.758906027406, 9736.61053557878, 9812.55843487059, 9876.604935802774, 6529.542931994904, 7386.556806591621, 7483.925160748323, 7581.810454738676, 7683.346915512244, 8235.423520353757, 8249.340052795642, 8298.460600060977, 8304.626291817003, 8322.70870519529, 7222.133343998544, 7352.632368381666, 7516.924830751841, 7609.619519024137, 7693.769186924401, 7070.1869285030825, 7172.354488096096, 7239.710411583477, 7249.130104387507, 7258.818529536593, 6658.533902626769, 6741.2921643226755, 6751.122354093936, 6757.966210169115, 6764.154480689914, 4921.138800709933, 5008.77460514285, 5127.3847138343635, 5128.9487105129965, 5175.223716442564, 5100.285959965682, 5136.5377116059735, 5177.844664660066, 5179.611529135405, 5261.500157485033], "value": 4476.593278383453, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.3638713411775, 325.5507399788292, 328.1811879360995, 328.5580893697977, 331.39520375315055, 5096.898062038757, 5138.100832354342, 5202.791888324467, 5267.789288428463, 5288.89422211556, 5188.636795424312, 5224.50367215114, 5233.142234506752, 5242.9213561796605, 5248.0, 4053.716239863196, 4076.408920706496, 4091.509018917734, 4102.487189101363, 4147.357159640261, 3852.614738526139, 3888.0279930017496, 4057.797110144496, 4085.2646523625735, 4104.712670113078, 3994.8801535953967, 4017.6785857131504, 4042.3128068228325, 4054.067564460176, 4055.3105971984687, 3996.760194388346, 4010.4585880905997, 4011.65900898424, 4012.7993600320015, 4029.2344454553836, 3460.567429071366, 3524.9118772030647, 3528.400171970771, 3536.0, 3536.6993805526563, 4943.431505376891, 5002.374703162105, 5003.674761140551, 5011.173156429185, 5038.84883453497, 4626.421697287839, 4658.95341046592, 4670.789814458358, 4679.578837904571, 4679.906401871977, 5299.33758280215, 5403.78384864605, 5434.429384914606, 5437.945620543823, 5441.727913604304, 3947.2500224957453, 3960.980195099035, 3961.4057891316247, 3970.325044742372, 3985.7608543487486, 5632.0, 5634.267545219095, 5658.943410565883, 5666.676662568328, 5670.4896559309445, 4019.437278780973, 4036.273470775289, 4036.313826649418, 4078.1232035112594, 4079.8776036718946, 4009.8797036088963, 4101.753894766323, 4108.198901214235, 4122.628963393309, 4164.500259968823, 4663.183942809995, 4676.789544470439, 4705.55297246761, 4706.552877476634, 4717.834875779331, 5274.551663108602, 5489.368722596872, 5489.451054894478, 5536.972315138399, 5537.972310138504, 1417.4117741137518, 1500.3848422147087, 1504.3982407037272, 1512.10785636475, 1515.727169109571, 1017.4658304390107, 1033.4161198922584, 1045.4459136657583, 1045.9163266938626, 1050.9054185123375, 5622.493975542221, 5625.296837895263, 5629.802956896489, 5642.633228840113, 5646.2377579027125, 5979.611325263931, 5981.700914954235, 5985.760569577255, 5989.64062156272, 6001.849953751103, 5498.917516237259, 5568.860778480571, 5572.777088916398, 5594.860128496739, 5627.352854421712, 3142.292984078564, 3165.2561648012697, 3172.032530078302, 3182.7772055956325, 3186.85659145339, 5927.318358388754, 6145.84635384119, 6147.170132032208, 6152.938470615326, 6175.197224360804, 6033.849153771191, 6063.666498342545, 6093.238345206849, 6100.267967843887, 6110.114033465123, 6099.817005489843, 6125.908111378333, 6127.724252408563, 6137.202163718688, 6141.0, 5787.276590426197, 5902.291724993029, 5926.911096333644, 5934.495567876606, 5955.851103722268, 5866.442687944638, 5870.295564532284, 5884.558658100574, 5898.4101589842385, 5923.940760592339, 5958.225430693982, 6129.570930034854, 6154.661493617894, 6164.537659675632, 6167.290761562478, 4233.322668373045, 4256.276433006458, 4272.060146767706, 4273.337632666941, 4290.12052529237, 5395.78416863321, 5407.72961351923, 5947.48339173508, 5971.462568368867, 5972.820815375546, 5495.835124946258, 5578.832635020955, 5581.469760372758, 5592.440755924375, 5602.1036634138345, 5414.35027796667, 5470.945290547043, 5491.341039075336, 5509.256250406304, 5520.199571062093, 5197.648611360998, 5444.482774136609, 5459.617826752089, 5464.535514481314, 5488.670679759227, 5549.306336707911, 5563.193336966036, 5579.553635709215, 5591.30108736408, 5608.691521966331, 5199.0, 5398.325209348832, 5422.403535611158, 5446.591505637172, 5464.3442786865835], "value": 4279.827534029221, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.5795386399071, 840.4831028917214, 850.2942557677129, 852.7143406958669, 855.3841234311294, 14055.0, 14267.215303158322, 14377.78433323501, 14509.854901450983, 14606.634834129152, 13437.596872093829, 13851.861481385184, 13861.653458663539, 13878.861211387883, 13911.513097041605, 679.0628932073731, 787.5629025890628, 807.1041144329804, 811.1037303779298, 816.7508909782514, 812.5652775764967, 813.4062134641715, 814.6171299489231, 814.9429539932207, 815.355868863597, 853.4793775796759, 855.5807654249404, 855.6406309350057, 855.9786005349854, 855.9914400856005, 697.2295613347254, 713.5362014690467, 715.1275443958363, 824.431142511671, 843.2874221283037, 615.7136931326954, 616.8365383173418, 617.4813156948185, 617.6016469377272, 617.9258488981351, 14198.432062717478, 14209.857901420957, 14212.147271163763, 14224.644383890485, 14299.428022879176, 13377.197368157942, 13955.58133256004, 13980.930095349458, 14085.71828563423, 14125.223112728796, 11282.435878206139, 11509.712257193638, 11625.59310424131, 11767.7058073548, 11921.463534140985, 3829.5978922213326, 3846.961530384688, 3900.941485877714, 3930.0960779020984, 3980.9402858957137, 58225.70887145537, 58299.70850145722, 58329.125063124084, 58786.41213587895, 59173.40826591722, 10573.259871809054, 10646.840297395545, 10746.94626526878, 10842.457877106113, 10871.130309575216, 18954.526136846413, 18991.81008189928, 19028.526291582006, 19069.332573360145, 19184.808151918303, 8100.959495202486, 8282.337413006944, 8413.368997325226, 8473.830523389497, 8568.0, 4719.669623126417, 4761.857144285677, 4771.5228477152705, 4877.878053048702, 4896.877578060577, 3305.8512366943546, 3355.8489867956, 3384.0355498682757, 3384.086296699877, 3387.3733359328603, 602.9577929544978, 611.9541034422436, 614.950803935693, 623.9344868788803, 625.2996643758928, 701.3442431326725, 713.3365969648173, 741.7663436017638, 761.9580923049285, 768.4275214964775, 9421.340506164639, 9816.803663926681, 9833.26250531213, 9892.109710126124, 9913.256505762096, 648.9123968264319, 657.5594351784316, 706.2795948132875, 743.7211045857804, 744.2148533297315, 4285.721428107163, 4513.413256276663, 4543.795529201194, 4560.315952607069, 4563.543645635476, 65347.34652653413, 66026.66986665037, 68013.65993170002, 68095.0, 69324.6533767338, 58752.0, 59009.0, 60360.396396035474, 60671.0, 61501.38498614957, 52541.7372913133, 53076.73461632667, 53502.197467037244, 53913.73043134759, 54288.72855635697, 8444.324454043539, 8634.179752923463, 8734.956325218332, 8778.473291602524, 8971.192592666692, 35362.0, 36319.63680363163, 36772.0, 37159.0, 37438.438423423126, 47127.0, 47555.52444475649, 48137.27794083161, 48499.51500485091, 48908.51091489182, 10976.12191024732, 11160.665180044612, 11413.657590272305, 11572.18994670365, 11580.768384632429, 12760.170588911691, 12846.743065138831, 12930.224186548838, 12931.159474634118, 12985.48058077704, 12069.818952715892, 12076.818847717466, 12140.150189487005, 12299.385030748606, 12434.191777534432, 13294.135881167693, 13703.931480342535, 13726.588202353945, 13977.091489053179, 14135.0, 13264.53574124901, 13449.327533623475, 13701.794473082713, 13753.312334383041, 14017.789733153806, 10450.68647940563, 10543.736406589896, 10557.102646275152, 10914.30541468247, 11476.196666233618, 10626.681199564026, 10690.62582809598, 10749.193810464403, 10848.891511085103, 11003.834942475709], "value": 6834.536425088483, "unit": "score"}], "name": "dromaeo_css", "value": 7035.272352720563, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 105.0, 111.0, 111.0, 110.0, 99.0, 109.0, 109.0, 109.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 163.0, 179.0, 128.0, 161.0, 167.0, 127.0, 182.0, 127.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 158.0, 162.0, 162.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 104.0, 115.0, 75.0, 76.0, 75.0, 123.0, 118.0, 77.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 146.0, 94.0, 92.0, 93.0, 148.0, 92.0, 92.0, 155.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 55.0, 57.0, 55.0, 55.0, 80.0, 55.0, 54.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 62.0, 61.0, 60.0, 60.0, 61.0, 62.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 76.0, 76.0, 77.0, 76.0, 75.0, 84.0, 76.0, 79.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 122.0, 119.0, 122.0, 121.0, 128.0, 122.0, 161.0, 133.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 165.0, 165.0, 167.0, 166.0, 169.0, 165.0, 173.0, 163.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 71.0, 70.0, 70.0, 69.0, 69.0, 68.0, 67.0, 67.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1537.9999999999998, "alertThreshold": 2.0}]} 22:26:33 INFO - Return code: 0 22:26:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:26:33 ERROR - # TBPL SUCCESS # 22:26:33 INFO - Running post-action listener: _resource_record_post_action 22:26:33 INFO - Running post-run listener: _resource_record_post_run 22:26:34 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 537985024; Read time: 340; Write time: 400480 22:26:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 251170816; Read time: 168; Write time: 242576 22:26:34 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 286814208; Read time: 172; Write time: 157904 22:26:34 INFO - Running post-run listener: _upload_blobber_files 22:26:34 INFO - Blob upload gear active. 22:26:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:26:34 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 22:26:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:26:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:26:34 INFO - (blobuploader) - INFO - Open directory for files ... 22:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:26:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:35 INFO - (blobuploader) - INFO - Done attempting. 22:26:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:26:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:26:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:36 INFO - (blobuploader) - INFO - Done attempting. 22:26:36 INFO - (blobuploader) - INFO - Iteration through files over. 22:26:36 INFO - Return code: 0 22:26:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:26:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:26:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53d91a25c0583ee86c45fbd59e6b765570d44122357d53a27394bd66a14c87652d2e95c9475ce7c99032b065d9c8b508e69b6b699b063b34dba9681b1b48ff60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3debbe23ddc6638fb848905cfd40c9657d1f46c228fc443311b39ce761f59227392ef49b9bb932005fcde843ddbdcff804555658d7114bfc6bf6809c3e4f17a0"} 22:26:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:26:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:26:36 INFO - Contents: 22:26:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53d91a25c0583ee86c45fbd59e6b765570d44122357d53a27394bd66a14c87652d2e95c9475ce7c99032b065d9c8b508e69b6b699b063b34dba9681b1b48ff60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3debbe23ddc6638fb848905cfd40c9657d1f46c228fc443311b39ce761f59227392ef49b9bb932005fcde843ddbdcff804555658d7114bfc6bf6809c3e4f17a0"} 22:26:36 INFO - Running post-run listener: copy_logs_to_upload_dir 22:26:36 INFO - Copying logs to upload dir... 22:26:36 INFO - mkdir: /builds/slave/test/build/upload/logs 22:26:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.194783 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-25 22:26:35.931383) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 22:26:35.939101) ========= 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-1461643529.448870-377606384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53d91a25c0583ee86c45fbd59e6b765570d44122357d53a27394bd66a14c87652d2e95c9475ce7c99032b065d9c8b508e69b6b699b063b34dba9681b1b48ff60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3debbe23ddc6638fb848905cfd40c9657d1f46c228fc443311b39ce761f59227392ef49b9bb932005fcde843ddbdcff804555658d7114bfc6bf6809c3e4f17a0"} build_url:https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/BgRLa5UbS4Wtn6n6d33d4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53d91a25c0583ee86c45fbd59e6b765570d44122357d53a27394bd66a14c87652d2e95c9475ce7c99032b065d9c8b508e69b6b699b063b34dba9681b1b48ff60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3debbe23ddc6638fb848905cfd40c9657d1f46c228fc443311b39ce761f59227392ef49b9bb932005fcde843ddbdcff804555658d7114bfc6bf6809c3e4f17a0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 22:26:35.968986) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:26:35.969315) ========= 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-1461643529.448870-377606384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:26:36.018593) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 22:26:36.022006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 22:26:36.022742) ========= ========= Total master_lag: 0.15 =========