builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1463193815.0 results: success (0) buildid: 20160513165348 builduid: 11feeaf77154451cb21915446376703d revision: 1956edae83a4be83b828fcd4986e1403d007d5bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:34.996047) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:34.996465) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:34.996749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:35.014287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:35.014566) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 19:43:35-- 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% 87.5M=0s 2016-05-13 19:43:35 (87.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118912 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:35.149212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:35.149526) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020361 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:35.198850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 19:43:35.199166) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1956edae83a4be83b828fcd4986e1403d007d5bc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1956edae83a4be83b828fcd4986e1403d007d5bc --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 19:43:35,332 truncating revision to first 12 chars 2016-05-13 19:43:35,332 Setting DEBUG logging. 2016-05-13 19:43:35,333 attempt 1/10 2016-05-13 19:43:35,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1956edae83a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 19:43:36,654 unpacking tar archive at: mozilla-aurora-1956edae83a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.614088 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 19:43:36.825921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:36.826256) ========= script_repo_revision: 1956edae83a4be83b828fcd4986e1403d007d5bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:36.826697) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:36.826962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 19:43:36.836086) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-13 19:43:36.836483) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:43:37 INFO - MultiFileLogger online at 20160513 19:43:37 in /builds/slave/test 19:43:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:43:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:43:37 INFO - {'append_to_log': False, 19:43:37 INFO - 'base_work_dir': '/builds/slave/test', 19:43:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:43:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:43:37 INFO - 'branch': 'Mozilla-Aurora', 19:43:37 INFO - 'buildbot_json_path': 'buildprops.json', 19:43:37 INFO - 'config_files': ('talos/linux_config.py',), 19:43:37 INFO - 'default_actions': ('clobber', 19:43:37 INFO - 'read-buildbot-config', 19:43:37 INFO - 'download-and-extract', 19:43:37 INFO - 'populate-webroot', 19:43:37 INFO - 'create-virtualenv', 19:43:37 INFO - 'install', 19:43:37 INFO - 'run-tests'), 19:43:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:43:37 INFO - 'download_minidump_stackwalk': True, 19:43:37 INFO - 'download_symbols': 'ondemand', 19:43:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:43:37 INFO - 'tooltool.py': '/tools/tooltool.py', 19:43:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:43:37 INFO - '/tools/misc-python/virtualenv.py')}, 19:43:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:43:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:43:37 INFO - 'installer_path': 'installer.exe', 19:43:37 INFO - 'log_level': 'info', 19:43:37 INFO - 'log_name': 'talos', 19:43:37 INFO - 'log_to_console': True, 19:43:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:43:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:43:37 INFO - 'opt_config_files': (), 19:43:37 INFO - 'pip_index': False, 19:43:37 INFO - 'sps_profile': False, 19:43:37 INFO - 'sps_profile_interval': 0, 19:43:37 INFO - 'suite': 'dromaeojs', 19:43:37 INFO - 'system_bits': '32', 19:43:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:43:37 INFO - 'title': 'talos-linux64-ix-008', 19:43:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:43:37 INFO - 'use_talos_json': True, 19:43:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:43:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:43:37 INFO - 'work_dir': 'build'} 19:43:37 INFO - ##### 19:43:37 INFO - ##### Running clobber step. 19:43:37 INFO - ##### 19:43:37 INFO - Running pre-action listener: _resource_record_pre_action 19:43:37 INFO - Running main action method: clobber 19:43:37 INFO - rmtree: /builds/slave/test/build 19:43:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:43:38 INFO - Running post-action listener: _resource_record_post_action 19:43:38 INFO - ##### 19:43:38 INFO - ##### Running read-buildbot-config step. 19:43:38 INFO - ##### 19:43:38 INFO - Running pre-action listener: _resource_record_pre_action 19:43:38 INFO - Running main action method: read_buildbot_config 19:43:38 INFO - Using buildbot properties: 19:43:38 INFO - { 19:43:38 INFO - "project": "", 19:43:38 INFO - "product": "firefox", 19:43:38 INFO - "script_repo_revision": "production", 19:43:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 19:43:38 INFO - "repository": "", 19:43:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 19:43:38 INFO - "buildid": "20160513165348", 19:43:38 INFO - "pgo_build": "True", 19:43:38 INFO - "basedir": "/builds/slave/test", 19:43:38 INFO - "buildnumber": 330, 19:43:38 INFO - "slavename": "talos-linux64-ix-008", 19:43:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:43:38 INFO - "platform": "ubuntu64_hw", 19:43:38 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:43:38 INFO - "branch": "mozilla-aurora", 19:43:38 INFO - "repo_path": "releases/mozilla-aurora", 19:43:38 INFO - "revision": "1956edae83a4be83b828fcd4986e1403d007d5bc", 19:43:38 INFO - "stage_platform": "linux64-pgo", 19:43:38 INFO - "builduid": "11feeaf77154451cb21915446376703d", 19:43:38 INFO - "slavebuilddir": "test" 19:43:38 INFO - } 19:43:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 19:43:38 INFO - Running post-action listener: _resource_record_post_action 19:43:38 INFO - ##### 19:43:38 INFO - ##### Running download-and-extract step. 19:43:38 INFO - ##### 19:43:38 INFO - Running pre-action listener: _resource_record_pre_action 19:43:38 INFO - Running main action method: download_and_extract 19:43:38 INFO - mkdir: /builds/slave/test/build/tests 19:43: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')]} 19:43:38 INFO - https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:43:43 INFO - Downloaded 1361 bytes. 19:43:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:43:43 INFO - Using the following test package requirements: 19:43:43 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:43:43 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:43:43 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:43:43 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:43 INFO - u'jsshell-linux-x86_64.zip'], 19:43:43 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:43:43 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:43:43 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:43:43 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:43:43 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:43:43 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:43:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:43 INFO - https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:43:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:43:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:43:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:43:45 INFO - Downloaded 23812190 bytes. 19:43:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:43:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:43:46 INFO - Return code: 0 19:43:46 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:43: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')]} 19:43:46 INFO - https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:43:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:43:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:43:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:43:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:43:47 INFO - Downloaded 23812190 bytes. 19:43:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:43:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:43:49 INFO - Return code: 0 19:43:49 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')]} 19:43:49 INFO - https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:43:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:43:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:43:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:43:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:43:51 INFO - Downloaded 10840145 bytes. 19:43:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:43:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:43:51 INFO - Return code: 0 19:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:51 INFO - https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:43:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:43:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:43:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:43:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:43:52 INFO - Downloaded 62718094 bytes. 19:43:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:43:52 INFO - mkdir: /builds/slave/test/properties 19:43:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:43:52 INFO - Writing to file /builds/slave/test/properties/build_url 19:43:52 INFO - Contents: 19:43:52 INFO - build_url:https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:43:53 INFO - Running post-action listener: _resource_record_post_action 19:43:53 INFO - Running post-action listener: set_extra_try_arguments 19:43:53 INFO - ##### 19:43:53 INFO - ##### Running populate-webroot step. 19:43:53 INFO - ##### 19:43:53 INFO - Running pre-action listener: _resource_record_pre_action 19:43:53 INFO - Running main action method: populate_webroot 19:43:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:43:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:43:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:43:53 INFO - '--tppagecycles', 19:43:53 INFO - '7'], 19:43:53 INFO - 'tests': ['tsvgm']}}, 19:43:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:43:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:43:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:43:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:43:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:43:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:43:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:53 INFO - 'talos_options': ['--disable-e10s'], 19:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:43:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:43:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:53 INFO - 'talos_options': ['--disable-e10s'], 19:43:53 INFO - 'tests': ['damp', 'tps']}, 19:43:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:53 INFO - 'tests': ['damp', 'tps']}, 19:43:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:43:53 INFO - 'tests': ['dromaeo_dom']}, 19:43:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:43:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:43:53 INFO - 'tests': ['a11yr', 19:43:53 INFO - 'ts_paint', 19:43:53 INFO - 'tpaint', 19:43:53 INFO - 'sessionrestore', 19:43:53 INFO - 'sessionrestore_no_auto_restore', 19:43:53 INFO - 'tabpaint']}, 19:43:53 INFO - 'other-e10s': {'tests': ['a11yr', 19:43:53 INFO - 'ts_paint', 19:43:53 INFO - 'tpaint', 19:43:53 INFO - 'sessionrestore', 19:43:53 INFO - 'sessionrestore_no_auto_restore', 19:43:53 INFO - 'tabpaint']}, 19:43:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:43:53 INFO - 'ts_paint', 19:43:53 INFO - 'tpaint', 19:43:53 INFO - 'sessionrestore', 19:43:53 INFO - 'sessionrestore_no_auto_restore', 19:43:53 INFO - 'tabpaint']}, 19:43:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:43:53 INFO - 'ts_paint', 19:43:53 INFO - 'tpaint', 19:43:53 INFO - 'sessionrestore', 19:43:53 INFO - 'sessionrestore_no_auto_restore', 19:43:53 INFO - 'tabpaint']}, 19:43:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:43:53 INFO - 'tests': ['a11yr', 19:43:53 INFO - 'ts_paint', 19:43:53 INFO - 'tpaint', 19:43:53 INFO - 'sessionrestore', 19:43:53 INFO - 'sessionrestore_no_auto_restore', 19:43:53 INFO - 'tabpaint']}, 19:43:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:43:53 INFO - 'tests': ['a11yr', 19:43:53 INFO - 'ts_paint', 19:43:53 INFO - 'tpaint', 19:43:53 INFO - 'sessionrestore', 19:43:53 INFO - 'sessionrestore_no_auto_restore', 19:43:53 INFO - 'tabpaint']}, 19:43:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:43:53 INFO - 'tests': ['tsvgx', 19:43:53 INFO - 'tsvgr_opacity', 19:43:53 INFO - 'tart', 19:43:53 INFO - 'tscrollx', 19:43:53 INFO - 'cart']}, 19:43:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:43:53 INFO - 'tsvgr_opacity', 19:43:53 INFO - 'tart', 19:43:53 INFO - 'tscrollx', 19:43:53 INFO - 'cart']}, 19:43:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:53 INFO - 'talos_options': ['--disable-e10s'], 19:43:53 INFO - 'tests': ['tp5o']}, 19:43:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:53 INFO - 'tests': ['tp5o']}, 19:43:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:53 INFO - 'talos_options': ['--disable-e10s', 19:43:53 INFO - '--xperf_path', 19:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:43:53 INFO - 'tests': ['tp5n']}, 19:43:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:53 INFO - 'talos_options': ['--xperf_path', 19:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:43:53 INFO - 'tests': ['tp5n']}}, 19:43:53 INFO - 'talos.zip': {'path': '', 19:43:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:43:53 INFO - Running post-action listener: _resource_record_post_action 19:43:53 INFO - ##### 19:43:53 INFO - ##### Running create-virtualenv step. 19:43:53 INFO - ##### 19:43:53 INFO - Running pre-action listener: _resource_record_pre_action 19:43:53 INFO - Running main action method: create_virtualenv 19:43:53 INFO - Creating virtualenv /builds/slave/test/build/venv 19:43:53 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 19:43:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:43:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:43:53 INFO - Using real prefix '/usr' 19:43:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:43:54 INFO - Installing distribute.............................................................................................................................................................................................done. 19:43:56 INFO - Installing pip.................done. 19:43:56 INFO - Return code: 0 19:43:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c0a671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84410>, '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 0xe85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', '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 19:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:43:56 INFO - Using env: {'DISPLAY': ':0', 19:43:56 INFO - 'HOME': '/home/cltbld', 19:43:56 INFO - 'LANG': 'en_US.UTF-8', 19:43:56 INFO - 'LANGUAGE': 'en_US:en', 19:43:56 INFO - 'LOGNAME': 'cltbld', 19:43:56 INFO - 'MAIL': '/var/mail/cltbld', 19:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:56 INFO - 'MOZ_NO_REMOTE': '1', 19:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:56 INFO - 'NO_EM_RESTART': '1', 19:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:56 INFO - 'PWD': '/builds/slave/test', 19:43:56 INFO - 'SHELL': '/bin/bash', 19:43:56 INFO - 'SHLVL': '1', 19:43:56 INFO - 'TERM': 'linux', 19:43:56 INFO - 'TMOUT': '86400', 19:43:56 INFO - 'USER': 'cltbld', 19:43:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', 19:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:56 INFO - '_': '/tools/buildbot/bin/python'} 19:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:43:56 INFO - Cleaning up... 19:43:56 INFO - Return code: 0 19:43:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c0a671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84410>, '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 0xe85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', '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 19:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:43:56 INFO - Using env: {'DISPLAY': ':0', 19:43:56 INFO - 'HOME': '/home/cltbld', 19:43:56 INFO - 'LANG': 'en_US.UTF-8', 19:43:56 INFO - 'LANGUAGE': 'en_US:en', 19:43:56 INFO - 'LOGNAME': 'cltbld', 19:43:56 INFO - 'MAIL': '/var/mail/cltbld', 19:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:56 INFO - 'MOZ_NO_REMOTE': '1', 19:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:56 INFO - 'NO_EM_RESTART': '1', 19:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:56 INFO - 'PWD': '/builds/slave/test', 19:43:56 INFO - 'SHELL': '/bin/bash', 19:43:56 INFO - 'SHLVL': '1', 19:43:56 INFO - 'TERM': 'linux', 19:43:56 INFO - 'TMOUT': '86400', 19:43:56 INFO - 'USER': 'cltbld', 19:43:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', 19:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:56 INFO - '_': '/tools/buildbot/bin/python'} 19:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:56 INFO - Downloading/unpacking psutil>=0.7.1 19:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:43:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:58 INFO - Installing collected packages: psutil 19:43:58 INFO - Running setup.py install for psutil 19:43:58 INFO - building 'psutil._psutil_linux' extension 19:43:58 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 19:43:58 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 19:43:58 INFO - building 'psutil._psutil_posix' extension 19:43:58 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 19:43:58 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 19:43:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:59 INFO - Successfully installed psutil 19:43:59 INFO - Cleaning up... 19:43:59 INFO - Return code: 0 19:43:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c0a671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84410>, '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 0xe85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', '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 19:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:43:59 INFO - Using env: {'DISPLAY': ':0', 19:43:59 INFO - 'HOME': '/home/cltbld', 19:43:59 INFO - 'LANG': 'en_US.UTF-8', 19:43:59 INFO - 'LANGUAGE': 'en_US:en', 19:43:59 INFO - 'LOGNAME': 'cltbld', 19:43:59 INFO - 'MAIL': '/var/mail/cltbld', 19:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:59 INFO - 'MOZ_NO_REMOTE': '1', 19:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:59 INFO - 'NO_EM_RESTART': '1', 19:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:59 INFO - 'PWD': '/builds/slave/test', 19:43:59 INFO - 'SHELL': '/bin/bash', 19:43:59 INFO - 'SHLVL': '1', 19:43:59 INFO - 'TERM': 'linux', 19:43:59 INFO - 'TMOUT': '86400', 19:43:59 INFO - 'USER': 'cltbld', 19:43:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', 19:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:59 INFO - '_': '/tools/buildbot/bin/python'} 19:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:44:01 INFO - Installing collected packages: mozsystemmonitor 19:44:01 INFO - Running setup.py install for mozsystemmonitor 19:44:01 INFO - Successfully installed mozsystemmonitor 19:44:01 INFO - Cleaning up... 19:44:01 INFO - Return code: 0 19:44:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c0a671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84410>, '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 0xe85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', '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 19:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:44:01 INFO - Using env: {'DISPLAY': ':0', 19:44:01 INFO - 'HOME': '/home/cltbld', 19:44:01 INFO - 'LANG': 'en_US.UTF-8', 19:44:01 INFO - 'LANGUAGE': 'en_US:en', 19:44:01 INFO - 'LOGNAME': 'cltbld', 19:44:01 INFO - 'MAIL': '/var/mail/cltbld', 19:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:01 INFO - 'MOZ_NO_REMOTE': '1', 19:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:01 INFO - 'NO_EM_RESTART': '1', 19:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:01 INFO - 'PWD': '/builds/slave/test', 19:44:01 INFO - 'SHELL': '/bin/bash', 19:44:01 INFO - 'SHLVL': '1', 19:44:01 INFO - 'TERM': 'linux', 19:44:01 INFO - 'TMOUT': '86400', 19:44:01 INFO - 'USER': 'cltbld', 19:44:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', 19:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:01 INFO - '_': '/tools/buildbot/bin/python'} 19:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:01 INFO - Downloading/unpacking blobuploader==1.2.4 19:44:01 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 19:44:01 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 19:44:01 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 19:44:01 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 19:44:01 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 19:44:01 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 19:44:03 INFO - Downloading blobuploader-1.2.4.tar.gz 19:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:44:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:44:03 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 19:44:03 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 19:44:03 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 19:44:03 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 19:44:03 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 19:44:03 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 19:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:44:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:44:03 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 19:44:03 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 19:44:03 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 19:44:03 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 19:44:03 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 19:44:03 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 19:44:04 INFO - Downloading docopt-0.6.1.tar.gz 19:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:44:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:44:04 INFO - Running setup.py install for blobuploader 19:44:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:44:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:44:04 INFO - Running setup.py install for requests 19:44:04 INFO - Running setup.py install for docopt 19:44:04 INFO - Successfully installed blobuploader requests docopt 19:44:04 INFO - Cleaning up... 19:44:04 INFO - Return code: 0 19:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:44:04 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')]} 19:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:04 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')]} 19:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:04 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 0x7f1c0a671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84410>, '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 0xe85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', '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 19:44:04 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 19:44:04 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 19:44:04 INFO - Using env: {'DISPLAY': ':0', 19:44:04 INFO - 'HOME': '/home/cltbld', 19:44:04 INFO - 'LANG': 'en_US.UTF-8', 19:44:04 INFO - 'LANGUAGE': 'en_US:en', 19:44:04 INFO - 'LOGNAME': 'cltbld', 19:44:04 INFO - 'MAIL': '/var/mail/cltbld', 19:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:04 INFO - 'MOZ_NO_REMOTE': '1', 19:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:04 INFO - 'NO_EM_RESTART': '1', 19:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:04 INFO - 'PWD': '/builds/slave/test', 19:44:04 INFO - 'SHELL': '/bin/bash', 19:44:04 INFO - 'SHLVL': '1', 19:44:04 INFO - 'TERM': 'linux', 19:44:04 INFO - 'TMOUT': '86400', 19:44:04 INFO - 'USER': 'cltbld', 19:44:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', 19:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:04 INFO - '_': '/tools/buildbot/bin/python'} 19:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:44:05 INFO - Running setup.py (path:/tmp/pip-TGltGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:44:05 INFO - Running setup.py (path:/tmp/pip-CDyHox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:44:05 INFO - Running setup.py (path:/tmp/pip-9KZz6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:44:05 INFO - Running setup.py (path:/tmp/pip-qcnORi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:44:05 INFO - Running setup.py (path:/tmp/pip-8LGqQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:44:05 INFO - Running setup.py (path:/tmp/pip-TsTAb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:44:05 INFO - Running setup.py (path:/tmp/pip-_VLsgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:44:05 INFO - Running setup.py (path:/tmp/pip-HW0lWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:44:05 INFO - Running setup.py (path:/tmp/pip-LIni3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:44:05 INFO - Running setup.py (path:/tmp/pip-Q6idlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:44:05 INFO - Running setup.py (path:/tmp/pip-zI7E2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:44:05 INFO - Running setup.py (path:/tmp/pip-k1wr06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:44:05 INFO - Running setup.py (path:/tmp/pip-TvF01w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:44:05 INFO - Running setup.py (path:/tmp/pip-ClnNEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:06 INFO - Running setup.py (path:/tmp/pip-r8JtmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:44:06 INFO - Running setup.py (path:/tmp/pip-xH31jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:44:06 INFO - Running setup.py (path:/tmp/pip-TlpUVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:44:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:44:06 INFO - Running setup.py install for manifestparser 19:44:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:44:06 INFO - Running setup.py install for mozcrash 19:44:06 INFO - Running setup.py install for mozdebug 19:44:06 INFO - Running setup.py install for mozdevice 19:44:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:44:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:44:06 INFO - Running setup.py install for mozfile 19:44:06 INFO - Running setup.py install for mozhttpd 19:44:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:44:06 INFO - Running setup.py install for mozinfo 19:44:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:44:06 INFO - Running setup.py install for mozInstall 19:44:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:44:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:44:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:44:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:44:07 INFO - Running setup.py install for mozleak 19:44:07 INFO - Running setup.py install for mozlog 19:44:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:44:07 INFO - Running setup.py install for moznetwork 19:44:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:44:07 INFO - Running setup.py install for mozprocess 19:44:07 INFO - Running setup.py install for mozprofile 19:44:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:44:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:44:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:44:07 INFO - Running setup.py install for mozrunner 19:44:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:44:07 INFO - Running setup.py install for mozscreenshot 19:44:07 INFO - Running setup.py install for moztest 19:44:07 INFO - Running setup.py install for mozversion 19:44:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:44:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:44:07 INFO - Cleaning up... 19:44:08 INFO - Return code: 0 19:44:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c0a671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84410>, '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 0xe85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', '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 19:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:44:08 INFO - Using env: {'DISPLAY': ':0', 19:44:08 INFO - 'HOME': '/home/cltbld', 19:44:08 INFO - 'LANG': 'en_US.UTF-8', 19:44:08 INFO - 'LANGUAGE': 'en_US:en', 19:44:08 INFO - 'LOGNAME': 'cltbld', 19:44:08 INFO - 'MAIL': '/var/mail/cltbld', 19:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:08 INFO - 'MOZ_NO_REMOTE': '1', 19:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:08 INFO - 'NO_EM_RESTART': '1', 19:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:08 INFO - 'PWD': '/builds/slave/test', 19:44:08 INFO - 'SHELL': '/bin/bash', 19:44:08 INFO - 'SHLVL': '1', 19:44:08 INFO - 'TERM': 'linux', 19:44:08 INFO - 'TMOUT': '86400', 19:44:08 INFO - 'USER': 'cltbld', 19:44:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', 19:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:08 INFO - '_': '/tools/buildbot/bin/python'} 19:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:44:08 INFO - Running setup.py (path:/tmp/pip-F8zTVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:44:08 INFO - Running setup.py (path:/tmp/pip-znoXoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:44:08 INFO - Running setup.py (path:/tmp/pip-Rm1ztH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:44:08 INFO - Running setup.py (path:/tmp/pip-8as8ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:44:08 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)) 19:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:44:08 INFO - Running setup.py (path:/tmp/pip-iEVkGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:44:08 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)) 19:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:44:08 INFO - Running setup.py (path:/tmp/pip-fz0f9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:44:08 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)) 19:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:44:08 INFO - Running setup.py (path:/tmp/pip-Ye4bDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:44:08 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)) 19:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:44:08 INFO - Running setup.py (path:/tmp/pip-vUkUY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:44:08 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)) 19:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:44:08 INFO - Running setup.py (path:/tmp/pip-CjWBUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:44:08 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)) 19:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:44:08 INFO - Running setup.py (path:/tmp/pip-D8UASO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:44:08 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)) 19:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:44:08 INFO - Running setup.py (path:/tmp/pip-GGfuCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:44:09 INFO - Running setup.py (path:/tmp/pip-uoJhlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:44:09 INFO - Running setup.py (path:/tmp/pip-eJvJG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:44:09 INFO - Running setup.py (path:/tmp/pip-apNm2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:09 INFO - Running setup.py (path:/tmp/pip-8gpE0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:44:09 INFO - Running setup.py (path:/tmp/pip-yK6uYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:44:09 INFO - Running setup.py (path:/tmp/pip-3eQP4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:44:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:11 INFO - Downloading blessings-1.6.tar.gz 19:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:44:11 INFO - Installing collected packages: blessings 19:44:11 INFO - Running setup.py install for blessings 19:44:11 INFO - Successfully installed blessings 19:44:11 INFO - Cleaning up... 19:44:11 INFO - Return code: 0 19:44:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:44:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:44:11 INFO - Reading from file tmpfile_stdout 19:44:11 INFO - Current package versions: 19:44:11 INFO - argparse == 1.2.1 19:44:11 INFO - blessings == 1.6 19:44:11 INFO - blobuploader == 1.2.4 19:44:11 INFO - docopt == 0.6.1 19:44:11 INFO - manifestparser == 1.1 19:44:11 INFO - mozInstall == 1.12 19:44:11 INFO - mozcrash == 0.17 19:44:11 INFO - mozdebug == 0.1 19:44:11 INFO - mozdevice == 0.48 19:44:11 INFO - mozfile == 1.2 19:44:11 INFO - mozhttpd == 0.7 19:44:11 INFO - mozinfo == 0.9 19:44:11 INFO - mozleak == 0.1 19:44:11 INFO - mozlog == 3.1 19:44:11 INFO - moznetwork == 0.27 19:44:11 INFO - mozprocess == 0.22 19:44:11 INFO - mozprofile == 0.28 19:44:11 INFO - mozrunner == 6.11 19:44:11 INFO - mozscreenshot == 0.1 19:44:11 INFO - mozsystemmonitor == 0.0 19:44:11 INFO - moztest == 0.7 19:44:11 INFO - mozversion == 1.4 19:44:11 INFO - psutil == 3.1.1 19:44:11 INFO - requests == 1.2.3 19:44:11 INFO - wsgiref == 0.1.2 19:44:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:44:11 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')]} 19:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:11 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')]} 19:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:11 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 0x7f1c0a671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84410>, '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 0xe85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', '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 19:44:11 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 19:44:11 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 19:44:11 INFO - Using env: {'DISPLAY': ':0', 19:44:11 INFO - 'HOME': '/home/cltbld', 19:44:11 INFO - 'LANG': 'en_US.UTF-8', 19:44:11 INFO - 'LANGUAGE': 'en_US:en', 19:44:11 INFO - 'LOGNAME': 'cltbld', 19:44:11 INFO - 'MAIL': '/var/mail/cltbld', 19:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:11 INFO - 'MOZ_NO_REMOTE': '1', 19:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:11 INFO - 'NO_EM_RESTART': '1', 19:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:11 INFO - 'PWD': '/builds/slave/test', 19:44:11 INFO - 'SHELL': '/bin/bash', 19:44:11 INFO - 'SHLVL': '1', 19:44:11 INFO - 'TERM': 'linux', 19:44:11 INFO - 'TMOUT': '86400', 19:44:11 INFO - 'USER': 'cltbld', 19:44:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', 19:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:11 INFO - '_': '/tools/buildbot/bin/python'} 19:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:11 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)) 19:44:11 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)) 19:44:11 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)) 19:44:11 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)) 19:44:11 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)) 19:44:11 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)) 19:44:11 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)) 19:44:11 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)) 19:44:11 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)) 19:44:11 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)) 19:44:11 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)) 19:44:11 INFO - Cleaning up... 19:44:12 INFO - Return code: 0 19:44:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c0a671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84410>, '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 0xe85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', '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 19:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:44:12 INFO - Using env: {'DISPLAY': ':0', 19:44:12 INFO - 'HOME': '/home/cltbld', 19:44:12 INFO - 'LANG': 'en_US.UTF-8', 19:44:12 INFO - 'LANGUAGE': 'en_US:en', 19:44:12 INFO - 'LOGNAME': 'cltbld', 19:44:12 INFO - 'MAIL': '/var/mail/cltbld', 19:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:12 INFO - 'MOZ_NO_REMOTE': '1', 19:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:12 INFO - 'NO_EM_RESTART': '1', 19:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:12 INFO - 'PWD': '/builds/slave/test', 19:44:12 INFO - 'SHELL': '/bin/bash', 19:44:12 INFO - 'SHLVL': '1', 19:44:12 INFO - 'TERM': 'linux', 19:44:12 INFO - 'TMOUT': '86400', 19:44:12 INFO - 'USER': 'cltbld', 19:44:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', 19:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:12 INFO - '_': '/tools/buildbot/bin/python'} 19:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:12 INFO - Downloading/unpacking jsonschema 19:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:44:14 INFO - Downloading/unpacking functools32 (from jsonschema) 19:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:14 INFO - Downloading functools32-3.2.3-2.tar.gz 19:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:44:14 INFO - warning: no files found matching '*.txt' 19:44:14 INFO - no previously-included directories found matching 'build' 19:44:14 INFO - no previously-included directories found matching 'dist' 19:44:14 INFO - no previously-included directories found matching '.git*' 19:44:14 INFO - Installing collected packages: jsonschema, functools32 19:44:14 INFO - Running setup.py install for functools32 19:44:14 INFO - warning: no files found matching '*.txt' 19:44:14 INFO - no previously-included directories found matching 'build' 19:44:14 INFO - no previously-included directories found matching 'dist' 19:44:14 INFO - no previously-included directories found matching '.git*' 19:44:14 INFO - Successfully installed jsonschema functools32 19:44:14 INFO - Cleaning up... 19:44:14 INFO - Return code: 0 19:44:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:44: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')]} 19:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44: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')]} 19:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:14 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 0x7f1c0a671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe84410>, '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 0xe85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', '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 19:44:14 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 19:44:14 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 19:44:14 INFO - Using env: {'DISPLAY': ':0', 19:44:14 INFO - 'HOME': '/home/cltbld', 19:44:14 INFO - 'LANG': 'en_US.UTF-8', 19:44:14 INFO - 'LANGUAGE': 'en_US:en', 19:44:14 INFO - 'LOGNAME': 'cltbld', 19:44:14 INFO - 'MAIL': '/var/mail/cltbld', 19:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:14 INFO - 'MOZ_NO_REMOTE': '1', 19:44:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:14 INFO - 'NO_EM_RESTART': '1', 19:44:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:14 INFO - 'PWD': '/builds/slave/test', 19:44:14 INFO - 'SHELL': '/bin/bash', 19:44:14 INFO - 'SHLVL': '1', 19:44:14 INFO - 'TERM': 'linux', 19:44:14 INFO - 'TMOUT': '86400', 19:44:14 INFO - 'USER': 'cltbld', 19:44:14 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', 19:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:14 INFO - '_': '/tools/buildbot/bin/python'} 19:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:14 INFO - Downloading/unpacking flake8 19:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:44:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:44:16 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 19:44:16 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 19:44:16 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 19:44:16 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 19:44:16 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 19:44:16 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 19:44:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:44:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:44:16 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 19:44:16 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 19:44:16 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 19:44:16 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 19:44:16 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 19:44:16 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 19:44:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:44:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:44:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:44:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:44:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:44:17 INFO - no previously-included directories found matching 'docs/_build' 19:44:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:44:17 INFO - Running setup.py install for pep8 19:44:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:44:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:44:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:44:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:44:17 INFO - no previously-included directories found matching 'docs/_build' 19:44:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:44:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:44:17 INFO - Cleaning up... 19:44:17 INFO - Return code: 0 19:44:17 INFO - Running post-action listener: _resource_record_post_action 19:44:17 INFO - Running post-action listener: _start_resource_monitoring 19:44:17 INFO - Starting resource monitoring. 19:44:17 INFO - ##### 19:44:17 INFO - ##### Running install step. 19:44:17 INFO - ##### 19:44:17 INFO - Running pre-action listener: _resource_record_pre_action 19:44:17 INFO - Running main action method: install 19:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:44:17 INFO - Reading from file tmpfile_stdout 19:44:17 INFO - Detecting whether we're running mozinstall >=1.0... 19:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:44:17 INFO - Reading from file tmpfile_stdout 19:44:17 INFO - Output received: 19:44:17 INFO - Usage: mozinstall [options] installer 19:44:17 INFO - Options: 19:44:17 INFO - -h, --help show this help message and exit 19:44:17 INFO - -d DEST, --destination=DEST 19:44:17 INFO - Directory to install application into. [default: 19:44:17 INFO - "/builds/slave/test"] 19:44:17 INFO - --app=APP Application being installed. [default: firefox] 19:44:17 INFO - mkdir: /builds/slave/test/build/application 19:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:44:33 INFO - Reading from file tmpfile_stdout 19:44:33 INFO - Output received: 19:44:33 INFO - /builds/slave/test/build/application/firefox/firefox 19:44:33 INFO - Running post-action listener: _resource_record_post_action 19:44:33 INFO - ##### 19:44:33 INFO - ##### Running run-tests step. 19:44:33 INFO - ##### 19:44:33 INFO - Running pre-action listener: _resource_record_pre_action 19:44:33 INFO - Running main action method: run_tests 19:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:44:33 INFO - Python 2.7.3 19:44:33 INFO - Return code: 0 19:44:33 INFO - grabbing minidump binary from tooltool 19:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:33 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 0xe84410>, '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 0xe85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:44:33 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 19:44:33 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 19:44:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:44:33 INFO - Return code: 0 19:44:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:44:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:44:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:44:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:44:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:44:34 INFO - Return code: 0 19:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:44:34 INFO - Using env: {'DISPLAY': ':0', 19:44:34 INFO - 'HOME': '/home/cltbld', 19:44:34 INFO - 'LANG': 'en_US.UTF-8', 19:44:34 INFO - 'LANGUAGE': 'en_US:en', 19:44:34 INFO - 'LOGNAME': 'cltbld', 19:44:34 INFO - 'MAIL': '/var/mail/cltbld', 19:44:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:44:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:34 INFO - 'MOZ_NO_REMOTE': '1', 19:44:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:34 INFO - 'NO_EM_RESTART': '1', 19:44:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:34 INFO - 'PWD': '/builds/slave/test', 19:44:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:44:34 INFO - 'SHELL': '/bin/bash', 19:44:34 INFO - 'SHLVL': '1', 19:44:34 INFO - 'TERM': 'linux', 19:44:34 INFO - 'TMOUT': '86400', 19:44:34 INFO - 'USER': 'cltbld', 19:44:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704', 19:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:34 INFO - '_': '/tools/buildbot/bin/python'} 19:44:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:44:34 INFO - mozversion application_buildid: 20160513165348 19:44:34 INFO - mozversion application_changeset: 1956edae83a4be83b828fcd4986e1403d007d5bc 19:44:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:44:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:44:34 INFO - mozversion application_name: Firefox 19:44:34 INFO - mozversion application_remotingname: firefox-dev 19:44:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:44:34 INFO - mozversion application_vendor: Mozilla 19:44:34 INFO - mozversion application_version: 48.0a2 19:44:34 INFO - mozversion platform_buildid: 20160513165348 19:44:34 INFO - mozversion platform_changeset: 1956edae83a4be83b828fcd4986e1403d007d5bc 19:44:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:44:34 INFO - mozversion platform_version: 48.0a2 19:44:34 INFO - using testdate: 1463193874 19:44:34 INFO - actual date: 1463193874 19:44:34 INFO - starting webserver on 'localhost:50379' 19:44:34 INFO - SUITE-START | Running 2 tests 19:44:34 INFO - TEST-START | dromaeo_css 19:44:34 INFO - operating with platform_type : linux_ 19:44:34 INFO - Initialising browser for dromaeo_css test... 19:44:34 INFO - TEST-INFO | started process 20196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYKfbJX/profile http://localhost:50379/getInfo.html) 19:44:38 INFO - PROCESS | 20196 | __metrics Screen width/height:1600/1200 19:44:38 INFO - PROCESS | 20196 | colorDepth:24 19:44:38 INFO - PROCESS | 20196 | Browser inner width/height: 1024/697 19:44:38 INFO - PROCESS | 20196 | __metrics 19:44:39 ERROR - PROCESS | 20196 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:44:40 INFO - TEST-INFO | 20196: exit 0 19:44:40 INFO - Browser initialized. 19:44:40 INFO - Running cycle 1/1 for dromaeo_css test... 19:44:40 INFO - TEST-INFO | started process 20286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYKfbJX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:44:52 INFO - PROCESS | 20286 | RSS: Main: 141742080 19:44:52 INFO - PROCESS | 20286 | 19:45:43 INFO - PROCESS | 20286 | 1463193943253 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] 19:47:50 INFO - PROCESS | 20286 | Cycle 1(1): loaded http://localhost:50379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50379/tests/dromaeo/cssquery-ext.html) 19:47:51 INFO - PROCESS | 20286 | RSS: Main: 252956672 19:47:51 INFO - PROCESS | 20286 | 19:50:53 INFO - PROCESS | 20286 | Cycle 1(1): loaded http://localhost:50379/tests/dromaeo/cssquery-ext.html (next: http://localhost:50379/tests/dromaeo/cssquery-jquery.html) 19:50:54 INFO - PROCESS | 20286 | RSS: Main: 225005568 19:50:54 INFO - PROCESS | 20286 | 19:53:56 INFO - PROCESS | 20286 | Cycle 1(1): loaded http://localhost:50379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50379/tests/dromaeo/cssquery-mootools.html) 19:53:57 INFO - PROCESS | 20286 | RSS: Main: 230895616 19:53:57 INFO - PROCESS | 20286 | 19:56:58 INFO - PROCESS | 20286 | Cycle 1(1): loaded http://localhost:50379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50379/tests/dromaeo/cssquery-prototype.html) 19:56:59 INFO - PROCESS | 20286 | RSS: Main: 219451392 19:56:59 INFO - PROCESS | 20286 | 20:00:02 INFO - PROCESS | 20286 | Cycle 1(1): loaded http://localhost:50379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50379/tests/dromaeo/cssquery-yui.html) 20:00:02 INFO - PROCESS | 20286 | RSS: Main: 184725504 20:00:02 INFO - PROCESS | 20286 | 20:03:04 INFO - PROCESS | 20286 | Cycle 1(1): loaded http://localhost:50379/tests/dromaeo/cssquery-yui.html (next: http://localhost:50379/tests/dromaeo/cssquery-dojo.html) 20:03:05 INFO - PROCESS | 20286 | RSS: Main: 256081920 20:03:05 INFO - PROCESS | 20286 | 20:03:05 INFO - PROCESS | 20286 | __start_tp_report 20:03:05 INFO - PROCESS | 20286 | _x_x_mozilla_page_load 20:03:05 INFO - PROCESS | 20286 | _x_x_mozilla_page_load_details 20:03:05 INFO - PROCESS | 20286 | |i|pagename|runs| 20:03:05 INFO - PROCESS | 20286 | |0;dojo.html;3321.468565029595;3400.1839558505967;3421.846016929238;3449.5170676105336;3473.9478907816388;5670;5700.1164819453;5725.055365864628;5730.656160630355;5736.082226843706;5677.574181936361;5744.827655170341;5745.913811292834;5750.568707346944;5754.16564598133;4893.535114164149;5103.106956282645;5253.579713622901;5289.285946397225;5319.468053194669;5096.031753966753;5157.355330583677;5159.174532074869;5161.354830646169;5164.535191832734;5121.820736274231;5133.307003554528;5152.613553983448;5186.7147306898105;5194;5063.746812659352;5114.539691427789;5119.180931051052;5132.153194722866;5156.432792392834;4997;5021.297018417388;5037.4458809530925;5040.59675225981;5121.615878809104;5334.759935802898;5442.755076021588;5489.64317319373;5502.669839809624;5508.9724551377385;6019.819405417845;6024;6025.939740602582;6026.276846778371;6027.336992930774;5973.940260597382;6077.36187700294;6103.1455596216565;6123.984276525883;6133.3559976202305;5637.80267690633;5685.260916080924;5690.943090569082;5693.373728889819;5702.173184888251;6037.9396206038255;6216.129741836146;6219.968900155471;6221.06683997395;6234.812955611339;5790.276215473066;5867.14926335679;5868.559858010666;5870.383609720918;5877.794277200277;6059.666718330446;6060.484858787053;6060.727267272983;6060.939390606038;6067.696615169224;5891.646501209942;6029.487493563009;6031.336552979169;6042.788502402483;6080.300765411946;6036.094585812163;6129.756146212572;6131.745619468117;6137.530208312589;6144.740328232701;4629.1436084324505;4630.120277147398;4632.86101416958;4637.721736695809;4665.346851440801;4026.134381108076;4065.1869626074313;4101.487314085739;4126.42230087788;4144.606262405066;5583.106702927512;5586.888262234733;5587.05020146576;5589.636673616202;5640.210370548127;5900.468957793819;5922.407759224043;5955.434233747787;5957.672328022;5965.433283838029;5486.039943009957;5610.354809196913;5726.513246374022;5768.480836724715;5807.419258074243;5121.718305493234;5124.205748109049;5124.769385377667;5125.461826508163;5127.948720512822;6096.512279017668;6102.938970610237;6109.694515274218;6132.264128304632;6167.96916015426;5953.017752070947;6014.609050411709;6092.847678808065;6132.724027418866;6141.048137538689;6185.741780432543;6229.034499652561;6233.96883015582;6235.282942461494;6236.656983865931;5813.302403711582;5893.32226793907;5907.940920590739;5910.674912879833;5944.702764861653;6016.037434010537;6081.726322315418;6082.087686847009;6091.42131497507;6131.938680613137;5839.299284085937;5878.2064421304285;5879.911801322898;5880.088586269135;5882.117682347682;5647.181158731879;5794.275715535558;5855.795047173328;5856.355800861987;5932.7033648318275;5822.94177058224;5857.297124345106;5859.267591551056;5862.325832529314;5897.3807750187325;5955.76176952917;5966.552508561962;5972.641641501524;5978.551608629457;5978.701064946822;5677.489025987681;5828;5860.677662728421;5867.119932010232;5938.554608404301 20:03:05 INFO - PROCESS | 20286 | |1;ext.html;654.5777973207281;659.2188256915553;660.887649099653;683.3200965039786;686.3239708886746;33035.17412064697;33589;33677.66322336776;33680;33695.494567581474;41671.58328416715;42564;42631.786841065754;42654.786726066326;42739.57260427395;8855.380123391382;9069.09309069091;9071.092890710943;9072.138146876036;9076.41003334781;8352.290055345304;8893.421927574687;9028.277737780994;10604.840927386056;10883;10699.144068474503;10803.945980270088;10810.459477026157;10811.027007569317;10816.080633146192;10581.947090264537;10658.307210031324;10663.893361066444;10665.893341066645;10679.359238445679;8248.587570621505;8490.617922193454;10267.229957753198;10510.264281500298;10513.528106065158;40939.385909211385;41260.79369603133;41404.37893431601;41414.792926035174;41476.1704765903;3875.341191997339;4225.148602661647;4386.254336762758;4387.824487020547;4472.306792447143;31982;32278;32360;32634.510482342783;33583.83208083968;4724.598409135193;4808.110499557558;4810.687305325143;4823.445303790074;4823.589994850442;366847;367300.1634991835;369774;370091;371230;62388.25670459787;62424;62747.6862615684;62842;62859.68570157211;73757;73927.63036184784;74311;75455.62272188604;75589;19610;19851.900740496207;19857.801421985885;19863.702044469344;19863.702044469344;14451.78322325166;15152.242387880562;15267;15275.236238188047;15283.312250948735;21631.891840540695;22349.888250558644;22513.43716407103;22554.323370298916;22602.208922687627;7969.681212751425;7985.72049978248;7996.32031277348;8252.174782521699;8477.830443391098;1082.837574363836;1085.5440714899603;1228.6252692928742;1255.171586752739;1266.1390254626942;34030;34034.82982585121;34193.487097693556;34623;35318.64681353205;1214.8420705308254;1237.826704261404;1266.8289780879463;1293.3274697157426;1315.651352391617;16171.191440428167;16324.683912474973;16569.502914912573;16609.584760380847;16939.57651058709;554769;559049;561005;561998;564249;63523;64183.35816641867;64207;64333.67833160804;64367;1534.4399294257516;1539.79982602261;1570.7879436276185;1579.5024567261275;1653.5039488153745;30386.392272154877;30624;31459.37081258316;31527;31983.36033279275;48872.26691599558;49168.75415622899;49559.504404955485;49561.50438495713;49615.25577116274;397716;402467;402620;403050;404131;31148;31572.36855262928;31878.840605796824;31879.6812031886;31911.521327179646;52263.47736522586;52463;52562.73718631535;53378.19932700935;53931;42871.7856410716;42958.78520607377;43031.569684304006;43138.78430607827;44728;41986.79006604947;43182.56817431786;43522.12955740804;43949.340759887986;44162.22048444368;44306.3354049696;44440.777796110815;44532.10935781331;44659.330110047726;45045.774771125936;36098.45852312165;37872.81063594665;37874.62125378711;38537.421938671505;38655.80672096734;29536;29611.555826662185;30114.69885301119;30125.698743013167;30199.396012080077 20:03:05 INFO - PROCESS | 20286 | |2;jquery.html;409.7009183296192;430.96584122939714;434.43957295089336;440.82367053178706;442.6432982907389;19023.239070437183;19133.33033343833;19551.511212219702;20250.797492025074;20678.79321206791;19525.12136953837;19907.40277791665;20111.195552177895;20153.899230503826;20154.49613759657;5617.550595952314;5665.291838520185;5685.061964775807;5773.076307790754;5834.737436815332;4192.958070419302;5789.623674461168;5809.535237181015;5957.076653118774;6234.345393733661;6207.937920620804;6218.347073557256;6235.158253635746;6236.906446403307;6238.282597501277;6051.515878729691;6111.480524155452;6153.292371377282;6184.876302473948;6295.307516173218;3857.286402015608;4071.409645601401;5368.838934831922;5633.549316054706;5646.040173170571;22254.332370028926;22299.888500557554;22537.661935070988;22610.095596176132;22647.886760566093;2515.1071369663873;2519.0553542421594;2540.4919016196836;2579.5485789986865;2815.53543665295;13640.590782276548;14017;14030.508932187324;14140;14558.4904528341;1992.3026940570685;2018.7880272571463;2066.390414827614;2155.75208850981;2170.804627583525;79053;84557.57721211416;84858.57570712168;85128.57435712844;85566.57216713938;10664.573417063386;10784.78430431387;11087.445627718582;11205.495752691148;11434.256773309875;15822.76265856013;15855.841441585437;16038.278277477542;16059.357625694842;16061.43784967544;8813;8901.332400070021;8907.910920890838;8933.463992160361;8957.641694332284;8807.119288071142;8819.426737262058;8892.73321800347;8946;8973.730788076367;6838.452923766087;6906.37842594169;6940.861182776316;6966.338197871295;6972.1284839395075;1799.6705654641228;1812.4562631210583;1916.1185854507082;1980.6430347886258;2031.1367668740727;1036.259074761534;1056.3872953686844;1125.4429057616533;1182.9408529573486;1189.4350183662864;17655.99549708858;18003.369882054067;18092.457226283233;18454.630907381776;19579.118939647466;1061.2783307351076;1083.7399024234128;1108.5233349659725;1118.7370967822717;1201.627495476405;11026.834597481044;11281.153913456523;11372.658820235407;11378.431078446045;11383.715407114889;566273;569240;584000;587383;601170;86441;87949;88187.55906220428;89566;89860.5506972461;1128.5147386623667;1128.7403897103711;1134.869490008643;1144.107596075046;1172.6247600767842;16983.91508042452;17544.122793860002;17560.736588951433;17560.91219543894;17744.733828992317;39780.2043959125;39898.2020359597;40090.599094009856;40679;41081;56695.14957275727;56859.14711279417;57150;57223;57543.712281438326;9201.907980920105;9218.769530761785;9227.723168304961;9268.62925483;9413.482258475575;14077.225752583707;14184.219867907364;14329.498467553585;14335.713285734018;14568.125912445286;12092.334921579397;12345.506179752709;12346.567870124503;12373.814392783936;12622.431990560262;11994.880051199376;12174.208676436358;12423.653664126012;12452.439640216393;12453.342382083345;12112.15214934946;12432;12648.304343261208;12755;12820.166689165175;8971.102889710977;9111.772205694911;9141.131592498701;9202.125798049176;9212.953935230282;12217.633470995885;12363.258204507758;12406.317652529198;12669.873301266869;12757.04322175822 20:03:05 INFO - PROCESS | 20286 | |3;mootools.html;1457.613732360924;1591.323687432841;1592.7292360298748;1838.2738818166824;1947.9220831166754;8221.83556328873;8456.746297611066;8471.279941205004;8471.407001509897;8481.236688698016;8149.674013039486;8298.336133109351;8304.252617264445;8336.70821521247;8342.165783421655;2142.700021996922;2338.53229354129;2402.5074859653773;2403.819713521484;2441.40185654514;2412.7949124324455;2419;2421.4430680943306;2423.018677435641;2423.987880060606;2304.446932736148;2371.893264803088;2372.893219805113;2374.8812559371963;2375.1212051540956;2070.4823794051413;2333.4516388648653;2386.85678859269;2387.713474383068;2392.4018995251186;2309.411100169446;2342.2153578551206;2363.645453182019;2372.3120295114395;2372.715274167094;8544.060153383123;8560.828783424358;8578.099299573518;8584.141585841428;8586.828263434696;5148.742562871841;5205.687658740488;5253.947460525423;5265.052290587692;5318.627696061278;3410.7100896423835;3422.26421319415;3478.565179352581;3521.506989021539;3569.303985722785;1172.0857730969772;1189.9226550274204;1205.5780476833127;1252.204849920298;1310.9016823738257;12384.81422778659;12565;12667.30329831859;12668.2399056056;12693.301868397235;4537.455505339381;4688.5545873142;4717.858464246078;4729.314249433813;4752.500987396343;10796.78406431867;10805.945970270099;10831.729206769895;10844.620438284623;10847.945760271306;4835.758212089381;5413.53984911287;5417.133258678593;5419.701916394636;5424.213489044067;4767.022760334124;4782.3543821584335;4795.448523419782;4816.422029356429;4842.733649649233;4078.1028173801715;4101.2207680540605;4122.416637180438;4161.146964872194;4211.136716973013;1288.6327396691897;1300.460308971785;1304.1327517201146;1312.553731731216;1331.4807225182187;880.55972013993;991.4051569058507;1025.236199031726;1049.9580016799243;1099.9945000275106;5892.911606325909;5943.257092863392;5954.49386802118;5967.492763115097;6117.84705382369;988.1008282462924;1002.2983911262146;1057.7249915021996;1091.8307662312195;1092.82514797632;4006.819693113817;4097.487814023247;4365.563443655673;4491.932621010622;4592.3800286961505;11003.119750419946;11212;11311.038561722346;11337.546498139982;11390.772184556428;10903;10907.509162087725;11074.335539867634;11093.944530277297;11113.277636953571;8159.510429374138;8345.4158208926;8384.329253659693;8418.494890306602;8421.873671894926;6053.818385448443;6154.599951003171;6216.285127210429;6241.188645476059;6357.396047375492;9678;9732.805343893224;9770.706878793648;9776.560054797408;9835.803283934138;9751.414915105117;10061.798764024825;10070.345427547187;10078.546465408928;10158.542865570918;7008.5094043416475;7581.848363032819;7818.648160832662;7874.37005039584;7989.680412783424;8340.916590834015;8366.24703776663;8385.95807020961;8411.831763364577;8431.704890328809;7176;7218.530795498275;7383.335499805044;7480.663370148248;7518.248175182657;7447.664855081426;7645.1972542882195;7647.082350117799;7750.457467977188;7757.495762775401;7134.821629459305;7137.678804453708;7181.533200341961;7186.1376634804155;7198.388137008204;5376.112941364631;5426.213199086189;5514.944850551443;5581.665100093845;5588.580856435702;5180.6891586504935;5196.662216955886;5211.218317252443;5374.3013408256675;5375.973120134531 20:03:05 INFO - PROCESS | 20286 | |4;prototype.html;327.7116137798737;331.8075516200604;342.912557297889;353.1506726323193;354.9024018394942;6252.562320637558;6256.311805701375;6332.841678958022;6378.298387177419;6414.967925160379;5913.172155898167;6143.109249158881;6283.7486500540035;6301.495880329574;6313;4788.305695674125;4818.807247710096;4828.97585512072;4829.22732362822;4838.153323168449;4812.663113582051;4829.541193586604;4840.177169881111;4847.806087756486;4853.466118726938;4576.908461830762;4653.302004699289;4788.78450469728;4802.23164293713;4812.350332705092;4758.904821903578;4763.7141771493825;4774.832880849171;4775.856724298276;4783.808647654089;4233.9364909526075;4235.49174099107;4238.597333253336;4245.469316335458;4250.489941207075;6003.339632640406;6011.9098213526395;6023.728932198062;6029.246344206974;6034.2155519782145;5613.691246981414;5614.1859430382365;5619.971900140514;5626.156076588503;5630.831075067755;6503.837404064889;6609.239937407212;6615.801525954229;6618.238902526223;6622.503312251552;4688.976555117202;4701.623870090384;4708.293755936603;4709.929351059703;4711.434627844681;6860.931390686079;6872.072270243503;6874.278200788895;6886.724531018804;6889.862202755917;4822.180229361017;4825.927611085836;4832.202686556679;4835.2505361669;4841.757912104381;4895.657303988758;4902.7058376497525;4907.9263811042865;4908.631852611068;4910.779014944336;5299.417064122943;5442.537384322377;5444.646098003617;5589.133684278943;5606.887862242814;6549.083128362033;6559.737610495622;6642.701078451481;6668.799936001928;6672.766453174116;1590.157216675164;1631.5594789406794;1637.0341498515934;1671.1310118738188;1679.6892574873686;1083.268793564341;1096.742265567591;1099.934003959749;1102.8014957307762;1104.8950349716924;6323.936760632427;6355.332690067568;6355.809325720235;6356.491480681627;6368.745250190033;6794.898076528757;6803.591784492946;6810.761623343159;6819.693113809891;6831.180258369028;6291.96854015727;6300.243970723451;6300.653464059429;6327.303996560375;6328.936710632835;3641.1443310821937;3669.1010702377553;3671.0638787109115;3674.669279764834;3674.797886116236;6975.930240697629;7058.505904586629;7207.711691532385;7218.8917166242545;7233.095863017123;6993;6996.160460744642;6997.825054373579;7011.053507776385;7036.050133232051;7189.748358807521;7208.56748595086;7215.124067742425;7216.67524961378;7221.386182174469;6940;7004.859902801813;7021.403180729695;7035.366816986496;7038;6582.80251592453;6746.156730408699;6866.038754574263;6872.244053154049;6888.758893438706;7192.964035179791;7211.495195336276;7212.639368031472;7218.205997340393;7221.927780722125;4713.81144754206;4747.311639812277;4757.904841903073;4759.905221799075;4766.713997160182;6636.336366363518;6900;6903.309669033057;6919.065926099912;6919.169699636076;6483.870322593616;6611.074449576967;6665.200175978914;6753.966230168818;6754.628495432602;6666.333366663295;6693.263740988585;6699.76550820719;6702.329767023259;6703.731850725916;6575.112359831362;6589.044588534732;6594.934050659432;6599.241087275025;6601.405873471411;6603.471722262111;6702.229243636849;6703.731850725916;6730.899036514554;6747.898781518183;6507.219133703986;6547.345265473415;6553.606783593;6572.638504882086;6578.079068930258 20:03:05 INFO - PROCESS | 20286 | |5;yui.html;790.6046976511744;819.0458116294514;860.2945584620612;936.3632729743772;941.2422999485411;15351.769723454157;15732.685346293067;15810.051396916193;15861.127637979907;15866.286017129229;15101.471448499306;15951.282192301345;15956.840431595681;16024.278907449163;16026;736.7310931509987;889.1553024626614;898.0794685447436;901.6663834381255;914.6158613382395;900.2078171209326;904.1230006893303;904.2856143646544;905.3933864310894;907.3285768531306;955.7180631713626;956.5121787888193;958.4249450329816;958.6644674363952;959.0217977662779;772.7527191298786;940.7836197674538;949.2216382566298;952.3761935931975;955.6702937486556;695.9095317608729;700.6846918886522;700.7547358424562;701.253165378875;701.3687681087011;15563.766543501857;16017.839821601752;16042.438514652047;16058.27737751804;16062.5984350391;14185.43258269668;14519.346629401702;14713.779293310608;14825.258737063104;14891.776623350659;12000.699982500508;12021.066819758915;12036.277823330629;12109.878901210963;12178.208416452992;3956.6636835868985;3983.8008099594904;4018.9196216075807;4025.657819085381;4041.7372870763306;59893.10160347598;59926.70036649789;60261.69869150626;60445.39554604442;60572;11031.613893513688;11479.71300717472;11557.88442115568;11778.411079445994;12006.819897701542;20375.28686495995;20376.592468150553;20434.79565204329;20474.38576842697;20515.8974205131;8721.869171962426;8808.471491710518;8817.691380801642;8829.779255518664;9124.908750912538;5197.896042079213;5296.576273898079;5328.280682107943;5372.516473517324;5409.540189083893;3644.0889777555612;3704.6110158433517;3707.4068149096015;3710.109573702346;3711.31340701971;611.7981066248217;623.5697368815503;654.8002859127917;669.8459354348527;671.1845108193568;621.0683974038942;654.450261780107;732.1763016606318;764.3312101910828;781.620913856779;9505.66730164441;9834.516307132157;9890.357126786736;9965.103140717225;10195.439250841275;724.713738073458;740.4335683202354;748.644393912887;757.2124990010437;765.2462324610254;4554.294084416921;4560.908781824345;4626.7223966562115;4684.0866031123605;4687.484376718558;70044;70529.2947070533;71260.28739712537;71502.64248678827;71503;63152.68423657852;63587.36412635907;64088;64827.675861621334;64898;54984.725076375165;55384;56237.437625624036;56602.43397566054;57989.13016304759;9098.408603440756;9171.128742769426;9216.815663686823;9221;9228.169464747936;40561.59438405578;41139;41286.58713412828;42588;43499.565004350814;49118.508814911394;50348.49651503438;54493.45506544884;54675;55528;12723.300218487702;13098.148620339647;13387;13577.321133943065;13782.241976691379;14278.571642850731;14640.26798660084;14815.629609259855;14831.406743730562;14992.47526336573;10850.565977360817;13359.332033398485;13563.86436135626;13968.231747253592;14192.290385480892;13136.080474366703;13332.93333533326;13475.460981560627;13506.797398039234;13600.86399135996;14398.352074156479;14567.125972441687;14601.342939567532;14822.851771482146;15102.471413500474;11963.342016189194;12054.337011464102;12092.758144836878;12300.692482687646;12425.19236249641;11911.3448760319;11944;12021.75956480883;12123.45444454984;12276.508939642314 20:03:05 INFO - PROCESS | 20286 | __end_tp_report 20:03:05 INFO - PROCESS | 20286 | __start_cc_report 20:03:05 INFO - PROCESS | 20286 | _x_x_mozilla_cycle_collect,853 20:03:05 INFO - PROCESS | 20286 | __end_cc_report 20:03:05 INFO - PROCESS | 20286 | __startTimestamp1463194985185__endTimestamp 20:03:05 INFO - PROCESS | 20286 | 20:03:05 INFO - PROCESS | 20286 | ------- Summary: start ------- 20:03:05 INFO - PROCESS | 20286 | Number of tests: 6 20:03:05 INFO - PROCESS | 20286 | 20:03:05 INFO - PROCESS | 20286 | [#0] dojo.html Cycles:165 Average:5599.77 Median:5839.30 stddev:621.22 (10.6%) stddev-sans-first:596.86 20:03:05 INFO - PROCESS | 20286 | Values: 3321.5 3400.2 3421.8 3449.5 3473.9 5670.0 5700.1 5725.1 5730.7 5736.1 5677.6 5744.8 5745.9 5750.6 5754.2 4893.5 5103.1 5253.6 5289.3 5319.5 5096.0 5157.4 5159.2 5161.4 5164.5 5121.8 5133.3 5152.6 5186.7 5194.0 5063.7 5114.5 5119.2 5132.2 5156.4 4997.0 5021.3 5037.4 5040.6 5121.6 5334.8 5442.8 5489.6 5502.7 5509.0 6019.8 6024.0 6025.9 6026.3 6027.3 5973.9 6077.4 6103.1 6124.0 6133.4 5637.8 5685.3 5690.9 5693.4 5702.2 6037.9 6216.1 6220.0 6221.1 6234.8 5790.3 5867.1 5868.6 5870.4 5877.8 6059.7 6060.5 6060.7 6060.9 6067.7 5891.6 6029.5 6031.3 6042.8 6080.3 6036.1 6129.8 6131.7 6137.5 6144.7 4629.1 4630.1 4632.9 4637.7 4665.3 4026.1 4065.2 4101.5 4126.4 4144.6 5583.1 5586.9 5587.1 5589.6 5640.2 5900.5 5922.4 5955.4 5957.7 5965.4 5486.0 5610.4 5726.5 5768.5 5807.4 5121.7 5124.2 5124.8 5125.5 5127.9 6096.5 6102.9 6109.7 6132.3 6168.0 5953.0 6014.6 6092.8 6132.7 6141.0 6185.7 6229.0 6234.0 6235.3 6236.7 5813.3 5893.3 5907.9 5910.7 5944.7 6016.0 6081.7 6082.1 6091.4 6131.9 5839.3 5878.2 5879.9 5880.1 5882.1 5647.2 5794.3 5855.8 5856.4 5932.7 5822.9 5857.3 5859.3 5862.3 5897.4 5955.8 5966.6 5972.6 5978.6 5978.7 5677.5 5828.0 5860.7 5867.1 5938.6 20:03:05 INFO - PROCESS | 20286 | 20:03:05 INFO - PROCESS | 20286 | [#1] ext.html Cycles:180 Average:61844.06 Median:200795.67 stddev:119559.49 (59.5%) stddev-sans-first:119806.62 20:03:05 INFO - PROCESS | 20286 | Values: 654.6 659.2 660.9 683.3 686.3 33035.2 33589.0 33677.7 33680.0 33695.5 41671.6 42564.0 42631.8 42654.8 42739.6 8855.4 9069.1 9071.1 9072.1 9076.4 8352.3 8893.4 9028.3 10604.8 10883.0 10699.1 10803.9 10810.5 10811.0 10816.1 10581.9 10658.3 10663.9 10665.9 10679.4 8248.6 8490.6 10267.2 10510.3 10513.5 40939.4 41260.8 41404.4 41414.8 41476.2 3875.3 4225.1 4386.3 4387.8 4472.3 31982.0 32278.0 32360.0 32634.5 33583.8 4724.6 4808.1 4810.7 4823.4 4823.6 366847.0 367300.2 369774.0 370091.0 371230.0 62388.3 62424.0 62747.7 62842.0 62859.7 73757.0 73927.6 74311.0 75455.6 75589.0 19610.0 19851.9 19857.8 19863.7 19863.7 14451.8 15152.2 15267.0 15275.2 15283.3 21631.9 22349.9 22513.4 22554.3 22602.2 7969.7 7985.7 7996.3 8252.2 8477.8 1082.8 1085.5 1228.6 1255.2 1266.1 34030.0 34034.8 34193.5 34623.0 35318.6 1214.8 1237.8 1266.8 1293.3 1315.7 16171.2 16324.7 16569.5 16609.6 16939.6 554769.0 559049.0 561005.0 561998.0 564249.0 63523.0 64183.4 64207.0 64333.7 64367.0 1534.4 1539.8 1570.8 1579.5 1653.5 30386.4 30624.0 31459.4 31527.0 31983.4 48872.3 49168.8 49559.5 49561.5 49615.3 397716.0 402467.0 402620.0 403050.0 404131.0 31148.0 31572.4 31878.8 31879.7 31911.5 52263.5 52463.0 52562.7 53378.2 53931.0 42871.8 42958.8 43031.6 43138.8 44728.0 41986.8 43182.6 43522.1 43949.3 44162.2 44306.3 44440.8 44532.1 44659.3 45045.8 36098.5 37872.8 37874.6 38537.4 38655.8 29536.0 29611.6 30114.7 30125.7 30199.4 20:03:05 INFO - PROCESS | 20286 | 20:03:05 INFO - PROCESS | 20286 | [#2] jquery.html Cycles:180 Average:31881.19 Median:22277.11 stddev:95367.68 (428.1%) stddev-sans-first:95605.94 20:03:05 INFO - PROCESS | 20286 | Values: 409.7 431.0 434.4 440.8 442.6 19023.2 19133.3 19551.5 20250.8 20678.8 19525.1 19907.4 20111.2 20153.9 20154.5 5617.6 5665.3 5685.1 5773.1 5834.7 4193.0 5789.6 5809.5 5957.1 6234.3 6207.9 6218.3 6235.2 6236.9 6238.3 6051.5 6111.5 6153.3 6184.9 6295.3 3857.3 4071.4 5368.8 5633.5 5646.0 22254.3 22299.9 22537.7 22610.1 22647.9 2515.1 2519.1 2540.5 2579.5 2815.5 13640.6 14017.0 14030.5 14140.0 14558.5 1992.3 2018.8 2066.4 2155.8 2170.8 79053.0 84557.6 84858.6 85128.6 85566.6 10664.6 10784.8 11087.4 11205.5 11434.3 15822.8 15855.8 16038.3 16059.4 16061.4 8813.0 8901.3 8907.9 8933.5 8957.6 8807.1 8819.4 8892.7 8946.0 8973.7 6838.5 6906.4 6940.9 6966.3 6972.1 1799.7 1812.5 1916.1 1980.6 2031.1 1036.3 1056.4 1125.4 1182.9 1189.4 17656.0 18003.4 18092.5 18454.6 19579.1 1061.3 1083.7 1108.5 1118.7 1201.6 11026.8 11281.2 11372.7 11378.4 11383.7 566273.0 569240.0 584000.0 587383.0 601170.0 86441.0 87949.0 88187.6 89566.0 89860.6 1128.5 1128.7 1134.9 1144.1 1172.6 16983.9 17544.1 17560.7 17560.9 17744.7 39780.2 39898.2 40090.6 40679.0 41081.0 56695.1 56859.1 57150.0 57223.0 57543.7 9201.9 9218.8 9227.7 9268.6 9413.5 14077.2 14184.2 14329.5 14335.7 14568.1 12092.3 12345.5 12346.6 12373.8 12622.4 11994.9 12174.2 12423.7 12452.4 12453.3 12112.2 12432.0 12648.3 12755.0 12820.2 8971.1 9111.8 9141.1 9202.1 9213.0 12217.6 12363.3 12406.3 12669.9 12757.0 20:03:05 INFO - PROCESS | 20286 | 20:03:05 INFO - PROCESS | 20286 | [#3] mootools.html Cycles:180 Average:5841.00 Median:4759.76 stddev:3274.68 (68.8%) stddev-sans-first:3267.30 20:03:05 INFO - PROCESS | 20286 | Values: 1457.6 1591.3 1592.7 1838.3 1947.9 8221.8 8456.7 8471.3 8471.4 8481.2 8149.7 8298.3 8304.3 8336.7 8342.2 2142.7 2338.5 2402.5 2403.8 2441.4 2412.8 2419.0 2421.4 2423.0 2424.0 2304.4 2371.9 2372.9 2374.9 2375.1 2070.5 2333.5 2386.9 2387.7 2392.4 2309.4 2342.2 2363.6 2372.3 2372.7 8544.1 8560.8 8578.1 8584.1 8586.8 5148.7 5205.7 5253.9 5265.1 5318.6 3410.7 3422.3 3478.6 3521.5 3569.3 1172.1 1189.9 1205.6 1252.2 1310.9 12384.8 12565.0 12667.3 12668.2 12693.3 4537.5 4688.6 4717.9 4729.3 4752.5 10796.8 10805.9 10831.7 10844.6 10847.9 4835.8 5413.5 5417.1 5419.7 5424.2 4767.0 4782.4 4795.4 4816.4 4842.7 4078.1 4101.2 4122.4 4161.1 4211.1 1288.6 1300.5 1304.1 1312.6 1331.5 880.6 991.4 1025.2 1050.0 1100.0 5892.9 5943.3 5954.5 5967.5 6117.8 988.1 1002.3 1057.7 1091.8 1092.8 4006.8 4097.5 4365.6 4491.9 4592.4 11003.1 11212.0 11311.0 11337.5 11390.8 10903.0 10907.5 11074.3 11093.9 11113.3 8159.5 8345.4 8384.3 8418.5 8421.9 6053.8 6154.6 6216.3 6241.2 6357.4 9678.0 9732.8 9770.7 9776.6 9835.8 9751.4 10061.8 10070.3 10078.5 10158.5 7008.5 7581.8 7818.6 7874.4 7989.7 8340.9 8366.2 8386.0 8411.8 8431.7 7176.0 7218.5 7383.3 7480.7 7518.2 7447.7 7645.2 7647.1 7750.5 7757.5 7134.8 7137.7 7181.5 7186.1 7198.4 5376.1 5426.2 5514.9 5581.7 5588.6 5180.7 5196.7 5211.2 5374.3 5376.0 20:03:05 INFO - PROCESS | 20286 | 20:03:05 INFO - PROCESS | 20286 | [#4] prototype.html Cycles:180 Average:5581.76 Median:6325.62 stddev:1685.35 (26.6%) stddev-sans-first:1643.29 20:03:05 INFO - PROCESS | 20286 | Values: 327.7 331.8 342.9 353.2 354.9 6252.6 6256.3 6332.8 6378.3 6415.0 5913.2 6143.1 6283.7 6301.5 6313.0 4788.3 4818.8 4829.0 4829.2 4838.2 4812.7 4829.5 4840.2 4847.8 4853.5 4576.9 4653.3 4788.8 4802.2 4812.4 4758.9 4763.7 4774.8 4775.9 4783.8 4233.9 4235.5 4238.6 4245.5 4250.5 6003.3 6011.9 6023.7 6029.2 6034.2 5613.7 5614.2 5620.0 5626.2 5630.8 6503.8 6609.2 6615.8 6618.2 6622.5 4689.0 4701.6 4708.3 4709.9 4711.4 6860.9 6872.1 6874.3 6886.7 6889.9 4822.2 4825.9 4832.2 4835.3 4841.8 4895.7 4902.7 4907.9 4908.6 4910.8 5299.4 5442.5 5444.6 5589.1 5606.9 6549.1 6559.7 6642.7 6668.8 6672.8 1590.2 1631.6 1637.0 1671.1 1679.7 1083.3 1096.7 1099.9 1102.8 1104.9 6323.9 6355.3 6355.8 6356.5 6368.7 6794.9 6803.6 6810.8 6819.7 6831.2 6292.0 6300.2 6300.7 6327.3 6328.9 3641.1 3669.1 3671.1 3674.7 3674.8 6975.9 7058.5 7207.7 7218.9 7233.1 6993.0 6996.2 6997.8 7011.1 7036.1 7189.7 7208.6 7215.1 7216.7 7221.4 6940.0 7004.9 7021.4 7035.4 7038.0 6582.8 6746.2 6866.0 6872.2 6888.8 7193.0 7211.5 7212.6 7218.2 7221.9 4713.8 4747.3 4757.9 4759.9 4766.7 6636.3 6900.0 6903.3 6919.1 6919.2 6483.9 6611.1 6665.2 6754.0 6754.6 6666.3 6693.3 6699.8 6702.3 6703.7 6575.1 6589.0 6594.9 6599.2 6601.4 6603.5 6702.2 6703.7 6730.9 6747.9 6507.2 6547.3 6553.6 6572.6 6578.1 20:03:05 INFO - PROCESS | 20286 | 20:03:05 INFO - PROCESS | 20286 | [#5] yui.html Cycles:180 Average:16633.48 Median:26903.00 stddev:19628.58 (73.0%) stddev-sans-first:19647.59 20:03:05 INFO - PROCESS | 20286 | Values: 790.6 819.0 860.3 936.4 941.2 15351.8 15732.7 15810.1 15861.1 15866.3 15101.5 15951.3 15956.8 16024.3 16026.0 736.7 889.2 898.1 901.7 914.6 900.2 904.1 904.3 905.4 907.3 955.7 956.5 958.4 958.7 959.0 772.8 940.8 949.2 952.4 955.7 695.9 700.7 700.8 701.3 701.4 15563.8 16017.8 16042.4 16058.3 16062.6 14185.4 14519.3 14713.8 14825.3 14891.8 12000.7 12021.1 12036.3 12109.9 12178.2 3956.7 3983.8 4018.9 4025.7 4041.7 59893.1 59926.7 60261.7 60445.4 60572.0 11031.6 11479.7 11557.9 11778.4 12006.8 20375.3 20376.6 20434.8 20474.4 20515.9 8721.9 8808.5 8817.7 8829.8 9124.9 5197.9 5296.6 5328.3 5372.5 5409.5 3644.1 3704.6 3707.4 3710.1 3711.3 611.8 623.6 654.8 669.8 671.2 621.1 654.5 732.2 764.3 781.6 9505.7 9834.5 9890.4 9965.1 10195.4 724.7 740.4 748.6 757.2 765.2 4554.3 4560.9 4626.7 4684.1 4687.5 70044.0 70529.3 71260.3 71502.6 71503.0 63152.7 63587.4 64088.0 64827.7 64898.0 54984.7 55384.0 56237.4 56602.4 57989.1 9098.4 9171.1 9216.8 9221.0 9228.2 40561.6 41139.0 41286.6 42588.0 43499.6 49118.5 50348.5 54493.5 54675.0 55528.0 12723.3 13098.1 13387.0 13577.3 13782.2 14278.6 14640.3 14815.6 14831.4 14992.5 10850.6 13359.3 13563.9 13968.2 14192.3 13136.1 13332.9 13475.5 13506.8 13600.9 14398.4 14567.1 14601.3 14822.9 15102.5 11963.3 12054.3 12092.8 12300.7 12425.2 11911.3 11944.0 12021.8 12123.5 12276.5 20:03:05 INFO - PROCESS | 20286 | -------- Summary: end -------- 20:03:05 INFO - PROCESS | 20286 | 20:03:05 INFO - TEST-INFO | 20286: exit 0 20:03:05 INFO - TEST-OK | dromaeo_css | took 1111108ms 20:03:05 INFO - TEST-START | kraken 20:03:05 INFO - operating with platform_type : linux_ 20:03:05 INFO - Initialising browser for kraken test... 20:03:05 INFO - TEST-INFO | started process 20472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiJGnJE/profile http://localhost:50379/getInfo.html) 20:03:09 INFO - PROCESS | 20472 | __metrics Screen width/height:1600/1200 20:03:09 INFO - PROCESS | 20472 | colorDepth:24 20:03:09 INFO - PROCESS | 20472 | Browser inner width/height: 1024/697 20:03:09 INFO - PROCESS | 20472 | __metrics 20:03:10 ERROR - PROCESS | 20472 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:03:11 INFO - TEST-INFO | 20472: exit 0 20:03:11 INFO - Browser initialized. 20:03:11 INFO - Running cycle 1/1 for kraken test... 20:03:11 INFO - TEST-INFO | started process 20566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiJGnJE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:03:23 INFO - PROCESS | 20566 | RSS: Main: 142041088 20:03:23 INFO - PROCESS | 20566 | 20:03:25 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50379/tests/kraken/driver.html?testName=audio-beat-detection) 20:03:26 INFO - PROCESS | 20566 | RSS: Main: 197128192 20:03:26 INFO - PROCESS | 20566 | 20:03:29 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50379/tests/kraken/driver.html?testName=audio-dft) 20:03:29 INFO - PROCESS | 20566 | RSS: Main: 182874112 20:03:29 INFO - PROCESS | 20566 | 20:03:32 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50379/tests/kraken/driver.html?testName=audio-fft) 20:03:33 INFO - PROCESS | 20566 | RSS: Main: 273059840 20:03:33 INFO - PROCESS | 20566 | 20:03:35 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50379/tests/kraken/driver.html?testName=audio-oscillator) 20:03:35 INFO - PROCESS | 20566 | RSS: Main: 179015680 20:03:35 INFO - PROCESS | 20566 | 20:03:37 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:03:38 INFO - PROCESS | 20566 | RSS: Main: 177553408 20:03:38 INFO - PROCESS | 20566 | 20:03:41 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50379/tests/kraken/driver.html?testName=imaging-darkroom) 20:03:42 INFO - PROCESS | 20566 | RSS: Main: 212533248 20:03:42 INFO - PROCESS | 20566 | 20:03:45 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50379/tests/kraken/driver.html?testName=imaging-desaturate) 20:03:46 INFO - PROCESS | 20566 | RSS: Main: 211718144 20:03:46 INFO - PROCESS | 20566 | 20:03:48 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50379/tests/kraken/driver.html?testName=json-parse-financial) 20:03:49 INFO - PROCESS | 20566 | RSS: Main: 212889600 20:03:49 INFO - PROCESS | 20566 | 20:03:50 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:03:51 INFO - PROCESS | 20566 | RSS: Main: 194777088 20:03:51 INFO - PROCESS | 20566 | 20:03:53 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50379/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:03:53 INFO - PROCESS | 20566 | RSS: Main: 199634944 20:03:53 INFO - PROCESS | 20566 | 20:03:55 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:03:56 INFO - PROCESS | 20566 | RSS: Main: 212000768 20:03:56 INFO - PROCESS | 20566 | 20:03:58 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:03:59 INFO - PROCESS | 20566 | RSS: Main: 211410944 20:03:59 INFO - PROCESS | 20566 | 20:04:02 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:04:02 INFO - PROCESS | 20566 | RSS: Main: 209276928 20:04:02 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:50379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50379/tests/kraken/driver.html?testName=ai-astar) 20:04:04 INFO - PROCESS | 20566 | RSS: Main: 272551936 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | __start_tp_report 20:04:04 INFO - PROCESS | 20566 | _x_x_mozilla_page_load 20:04:04 INFO - PROCESS | 20566 | _x_x_mozilla_page_load_details 20:04:04 INFO - PROCESS | 20566 | |i|pagename|runs| 20:04:04 INFO - PROCESS | 20566 | |0;ai-astar;111;110;109;109;108;110;106;109;109;109 20:04:04 INFO - PROCESS | 20566 | |1;audio-beat-detection;159;127;156;173;132;160;154;127;176;127 20:04:04 INFO - PROCESS | 20566 | |2;audio-dft;161;160;160;160;162;160;160;162;158;161 20:04:04 INFO - PROCESS | 20566 | |3;audio-fft;75;76;76;165;76;73;77;74;160;75 20:04:04 INFO - PROCESS | 20566 | |4;audio-oscillator;92;94;162;91;93;91;156;92;92;145 20:04:04 INFO - PROCESS | 20566 | |5;imaging-gaussian-blur;116;117;117;117;116;116;117;117;116;117 20:04:04 INFO - PROCESS | 20566 | |6;imaging-darkroom;146;145;146;145;145;145;145;145;145;145 20:04:04 INFO - PROCESS | 20566 | |7;imaging-desaturate;94;94;94;95;94;94;95;94;95;94 20:04:04 INFO - PROCESS | 20566 | |8;json-parse-financial;53;55;54;55;54;54;56;74;53;54 20:04:04 INFO - PROCESS | 20566 | |9;json-stringify-tinderbox;57;58;57;58;57;58;60;58;58;60 20:04:04 INFO - PROCESS | 20566 | |10;stanford-crypto-aes;70;71;71;72;72;71;72;72;72;72 20:04:04 INFO - PROCESS | 20566 | |11;stanford-crypto-ccm;113;137;120;114;114;113;110;119;162;123 20:04:04 INFO - PROCESS | 20566 | |12;stanford-crypto-pbkdf2;160;155;152;156;154;159;158;155;157;154 20:04:04 INFO - PROCESS | 20566 | |13;stanford-crypto-sha256-iterative;66;65;65;67;68;68;64;66;67;65 20:04:04 INFO - PROCESS | 20566 | __end_tp_report 20:04:04 INFO - PROCESS | 20566 | __start_cc_report 20:04:04 INFO - PROCESS | 20566 | _x_x_mozilla_cycle_collect,1576 20:04:04 INFO - PROCESS | 20566 | __end_cc_report 20:04:04 INFO - PROCESS | 20566 | __startTimestamp1463195044530__endTimestamp 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | ------- Summary: start ------- 20:04:04 INFO - PROCESS | 20566 | Number of tests: 14 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.00 stddev:1.33 (1.2%) stddev-sans-first:1.20 20:04:04 INFO - PROCESS | 20566 | Values: 111.0 110.0 109.0 109.0 108.0 110.0 106.0 109.0 109.0 109.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:157.50 stddev:19.27 (12.2%) stddev-sans-first:20.10 20:04:04 INFO - PROCESS | 20566 | Values: 159.0 127.0 156.0 173.0 132.0 160.0 154.0 127.0 176.0 127.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 20:04:04 INFO - PROCESS | 20566 | Values: 161.0 160.0 160.0 160.0 162.0 160.0 160.0 162.0 158.0 161.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.50 stddev:36.82 (48.8%) stddev-sans-first:38.50 20:04:04 INFO - PROCESS | 20566 | Values: 75.0 76.0 76.0 165.0 76.0 73.0 77.0 74.0 160.0 75.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:92.00 stddev:30.33 (33.0%) stddev-sans-first:31.39 20:04:04 INFO - PROCESS | 20566 | Values: 92.0 94.0 162.0 91.0 93.0 91.0 156.0 92.0 92.0 145.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:04:04 INFO - PROCESS | 20566 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 20:04:04 INFO - PROCESS | 20566 | Values: 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:04:04 INFO - PROCESS | 20566 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:54.50 stddev:6.32 (11.6%) stddev-sans-first:6.60 20:04:04 INFO - PROCESS | 20566 | Values: 53.0 55.0 54.0 55.0 54.0 54.0 56.0 74.0 53.0 54.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:1.10 (1.9%) stddev-sans-first:1.09 20:04:04 INFO - PROCESS | 20566 | Values: 57.0 58.0 57.0 58.0 57.0 58.0 60.0 58.0 58.0 60.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#10] stanford-crypto-aes Cycles:10 Average:71.50 Median:72.00 stddev:0.71 (1.0%) stddev-sans-first:0.50 20:04:04 INFO - PROCESS | 20566 | Values: 70.0 71.0 71.0 72.0 72.0 71.0 72.0 72.0 72.0 72.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:119.50 stddev:15.88 (13.3%) stddev-sans-first:16.47 20:04:04 INFO - PROCESS | 20566 | Values: 113.0 137.0 120.0 114.0 114.0 113.0 110.0 119.0 162.0 123.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:156.50 stddev:2.49 (1.6%) stddev-sans-first:2.19 20:04:04 INFO - PROCESS | 20566 | Values: 160.0 155.0 152.0 156.0 154.0 159.0 158.0 155.0 157.0 154.0 20:04:04 INFO - PROCESS | 20566 | 20:04:04 INFO - PROCESS | 20566 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.37 (2.1%) stddev-sans-first:1.45 20:04:04 INFO - PROCESS | 20566 | Values: 66.0 65.0 65.0 67.0 68.0 68.0 64.0 66.0 67.0 65.0 20:04:04 INFO - PROCESS | 20566 | -------- Summary: end -------- 20:04:04 INFO - PROCESS | 20566 | 20:04:05 INFO - TEST-INFO | 20566: exit 0 20:04:05 INFO - TEST-OK | kraken | took 59591ms 20:04:05 INFO - SUITE-END | took 1170s 20:04:05 INFO - Completed test suite (00:19:30) 20:04:05 INFO - javascript benchmark 20:04:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3321.468565029595, 3400.1839558505967, 3421.846016929238, 3449.5170676105336, 3473.9478907816388, 5670.0, 5700.1164819453, 5725.055365864628, 5730.656160630355, 5736.082226843706, 5677.574181936361, 5744.827655170341, 5745.913811292834, 5750.568707346944, 5754.16564598133, 4893.535114164149, 5103.106956282645, 5253.579713622901, 5289.285946397225, 5319.468053194669, 5096.031753966753, 5157.355330583677, 5159.174532074869, 5161.354830646169, 5164.535191832734, 5121.820736274231, 5133.307003554528, 5152.613553983448, 5186.7147306898105, 5194.0, 5063.746812659352, 5114.539691427789, 5119.180931051052, 5132.153194722866, 5156.432792392834, 4997.0, 5021.297018417388, 5037.4458809530925, 5040.59675225981, 5121.615878809104, 5334.759935802898, 5442.755076021588, 5489.64317319373, 5502.669839809624, 5508.9724551377385, 6019.819405417845, 6024.0, 6025.939740602582, 6026.276846778371, 6027.336992930774, 5973.940260597382, 6077.36187700294, 6103.1455596216565, 6123.984276525883, 6133.3559976202305, 5637.80267690633, 5685.260916080924, 5690.943090569082, 5693.373728889819, 5702.173184888251, 6037.9396206038255, 6216.129741836146, 6219.968900155471, 6221.06683997395, 6234.812955611339, 5790.276215473066, 5867.14926335679, 5868.559858010666, 5870.383609720918, 5877.794277200277, 6059.666718330446, 6060.484858787053, 6060.727267272983, 6060.939390606038, 6067.696615169224, 5891.646501209942, 6029.487493563009, 6031.336552979169, 6042.788502402483, 6080.300765411946, 6036.094585812163, 6129.756146212572, 6131.745619468117, 6137.530208312589, 6144.740328232701, 4629.1436084324505, 4630.120277147398, 4632.86101416958, 4637.721736695809, 4665.346851440801, 4026.134381108076, 4065.1869626074313, 4101.487314085739, 4126.42230087788, 4144.606262405066, 5583.106702927512, 5586.888262234733, 5587.05020146576, 5589.636673616202, 5640.210370548127, 5900.468957793819, 5922.407759224043, 5955.434233747787, 5957.672328022, 5965.433283838029, 5486.039943009957, 5610.354809196913, 5726.513246374022, 5768.480836724715, 5807.419258074243, 5121.718305493234, 5124.205748109049, 5124.769385377667, 5125.461826508163, 5127.948720512822, 6096.512279017668, 6102.938970610237, 6109.694515274218, 6132.264128304632, 6167.96916015426, 5953.017752070947, 6014.609050411709, 6092.847678808065, 6132.724027418866, 6141.048137538689, 6185.741780432543, 6229.034499652561, 6233.96883015582, 6235.282942461494, 6236.656983865931, 5813.302403711582, 5893.32226793907, 5907.940920590739, 5910.674912879833, 5944.702764861653, 6016.037434010537, 6081.726322315418, 6082.087686847009, 6091.42131497507, 6131.938680613137, 5839.299284085937, 5878.2064421304285, 5879.911801322898, 5880.088586269135, 5882.117682347682, 5647.181158731879, 5794.275715535558, 5855.795047173328, 5856.355800861987, 5932.7033648318275, 5822.94177058224, 5857.297124345106, 5859.267591551056, 5862.325832529314, 5897.3807750187325, 5955.76176952917, 5966.552508561962, 5972.641641501524, 5978.551608629457, 5978.701064946822, 5677.489025987681, 5828.0, 5860.677662728421, 5867.119932010232, 5938.554608404301], "value": 5559.634302785237, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.5777973207281, 659.2188256915553, 660.887649099653, 683.3200965039786, 686.3239708886746, 33035.17412064697, 33589.0, 33677.66322336776, 33680.0, 33695.494567581474, 41671.58328416715, 42564.0, 42631.786841065754, 42654.786726066326, 42739.57260427395, 8855.380123391382, 9069.09309069091, 9071.092890710943, 9072.138146876036, 9076.41003334781, 8352.290055345304, 8893.421927574687, 9028.277737780994, 10604.840927386056, 10883.0, 10699.144068474503, 10803.945980270088, 10810.459477026157, 10811.027007569317, 10816.080633146192, 10581.947090264537, 10658.307210031324, 10663.893361066444, 10665.893341066645, 10679.359238445679, 8248.587570621505, 8490.617922193454, 10267.229957753198, 10510.264281500298, 10513.528106065158, 40939.385909211385, 41260.79369603133, 41404.37893431601, 41414.792926035174, 41476.1704765903, 3875.341191997339, 4225.148602661647, 4386.254336762758, 4387.824487020547, 4472.306792447143, 31982.0, 32278.0, 32360.0, 32634.510482342783, 33583.83208083968, 4724.598409135193, 4808.110499557558, 4810.687305325143, 4823.445303790074, 4823.589994850442, 366847.0, 367300.1634991835, 369774.0, 370091.0, 371230.0, 62388.25670459787, 62424.0, 62747.6862615684, 62842.0, 62859.68570157211, 73757.0, 73927.63036184784, 74311.0, 75455.62272188604, 75589.0, 19610.0, 19851.900740496207, 19857.801421985885, 19863.702044469344, 19863.702044469344, 14451.78322325166, 15152.242387880562, 15267.0, 15275.236238188047, 15283.312250948735, 21631.891840540695, 22349.888250558644, 22513.43716407103, 22554.323370298916, 22602.208922687627, 7969.681212751425, 7985.72049978248, 7996.32031277348, 8252.174782521699, 8477.830443391098, 1082.837574363836, 1085.5440714899603, 1228.6252692928742, 1255.171586752739, 1266.1390254626942, 34030.0, 34034.82982585121, 34193.487097693556, 34623.0, 35318.64681353205, 1214.8420705308254, 1237.826704261404, 1266.8289780879463, 1293.3274697157426, 1315.651352391617, 16171.191440428167, 16324.683912474973, 16569.502914912573, 16609.584760380847, 16939.57651058709, 554769.0, 559049.0, 561005.0, 561998.0, 564249.0, 63523.0, 64183.35816641867, 64207.0, 64333.67833160804, 64367.0, 1534.4399294257516, 1539.79982602261, 1570.7879436276185, 1579.5024567261275, 1653.5039488153745, 30386.392272154877, 30624.0, 31459.37081258316, 31527.0, 31983.36033279275, 48872.26691599558, 49168.75415622899, 49559.504404955485, 49561.50438495713, 49615.25577116274, 397716.0, 402467.0, 402620.0, 403050.0, 404131.0, 31148.0, 31572.36855262928, 31878.840605796824, 31879.6812031886, 31911.521327179646, 52263.47736522586, 52463.0, 52562.73718631535, 53378.19932700935, 53931.0, 42871.7856410716, 42958.78520607377, 43031.569684304006, 43138.78430607827, 44728.0, 41986.79006604947, 43182.56817431786, 43522.12955740804, 43949.340759887986, 44162.22048444368, 44306.3354049696, 44440.777796110815, 44532.10935781331, 44659.330110047726, 45045.774771125936, 36098.45852312165, 37872.81063594665, 37874.62125378711, 38537.421938671505, 38655.80672096734, 29536.0, 29611.555826662185, 30114.69885301119, 30125.698743013167, 30199.396012080077], "value": 21609.375160770276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.7009183296192, 430.96584122939714, 434.43957295089336, 440.82367053178706, 442.6432982907389, 19023.239070437183, 19133.33033343833, 19551.511212219702, 20250.797492025074, 20678.79321206791, 19525.12136953837, 19907.40277791665, 20111.195552177895, 20153.899230503826, 20154.49613759657, 5617.550595952314, 5665.291838520185, 5685.061964775807, 5773.076307790754, 5834.737436815332, 4192.958070419302, 5789.623674461168, 5809.535237181015, 5957.076653118774, 6234.345393733661, 6207.937920620804, 6218.347073557256, 6235.158253635746, 6236.906446403307, 6238.282597501277, 6051.515878729691, 6111.480524155452, 6153.292371377282, 6184.876302473948, 6295.307516173218, 3857.286402015608, 4071.409645601401, 5368.838934831922, 5633.549316054706, 5646.040173170571, 22254.332370028926, 22299.888500557554, 22537.661935070988, 22610.095596176132, 22647.886760566093, 2515.1071369663873, 2519.0553542421594, 2540.4919016196836, 2579.5485789986865, 2815.53543665295, 13640.590782276548, 14017.0, 14030.508932187324, 14140.0, 14558.4904528341, 1992.3026940570685, 2018.7880272571463, 2066.390414827614, 2155.75208850981, 2170.804627583525, 79053.0, 84557.57721211416, 84858.57570712168, 85128.57435712844, 85566.57216713938, 10664.573417063386, 10784.78430431387, 11087.445627718582, 11205.495752691148, 11434.256773309875, 15822.76265856013, 15855.841441585437, 16038.278277477542, 16059.357625694842, 16061.43784967544, 8813.0, 8901.332400070021, 8907.910920890838, 8933.463992160361, 8957.641694332284, 8807.119288071142, 8819.426737262058, 8892.73321800347, 8946.0, 8973.730788076367, 6838.452923766087, 6906.37842594169, 6940.861182776316, 6966.338197871295, 6972.1284839395075, 1799.6705654641228, 1812.4562631210583, 1916.1185854507082, 1980.6430347886258, 2031.1367668740727, 1036.259074761534, 1056.3872953686844, 1125.4429057616533, 1182.9408529573486, 1189.4350183662864, 17655.99549708858, 18003.369882054067, 18092.457226283233, 18454.630907381776, 19579.118939647466, 1061.2783307351076, 1083.7399024234128, 1108.5233349659725, 1118.7370967822717, 1201.627495476405, 11026.834597481044, 11281.153913456523, 11372.658820235407, 11378.431078446045, 11383.715407114889, 566273.0, 569240.0, 584000.0, 587383.0, 601170.0, 86441.0, 87949.0, 88187.55906220428, 89566.0, 89860.5506972461, 1128.5147386623667, 1128.7403897103711, 1134.869490008643, 1144.107596075046, 1172.6247600767842, 16983.91508042452, 17544.122793860002, 17560.736588951433, 17560.91219543894, 17744.733828992317, 39780.2043959125, 39898.2020359597, 40090.599094009856, 40679.0, 41081.0, 56695.14957275727, 56859.14711279417, 57150.0, 57223.0, 57543.712281438326, 9201.907980920105, 9218.769530761785, 9227.723168304961, 9268.62925483, 9413.482258475575, 14077.225752583707, 14184.219867907364, 14329.498467553585, 14335.713285734018, 14568.125912445286, 12092.334921579397, 12345.506179752709, 12346.567870124503, 12373.814392783936, 12622.431990560262, 11994.880051199376, 12174.208676436358, 12423.653664126012, 12452.439640216393, 12453.342382083345, 12112.15214934946, 12432.0, 12648.304343261208, 12755.0, 12820.166689165175, 8971.102889710977, 9111.772205694911, 9141.131592498701, 9202.125798049176, 9212.953935230282, 12217.633470995885, 12363.258204507758, 12406.317652529198, 12669.873301266869, 12757.04322175822], "value": 9796.778263428485, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.613732360924, 1591.323687432841, 1592.7292360298748, 1838.2738818166824, 1947.9220831166754, 8221.83556328873, 8456.746297611066, 8471.279941205004, 8471.407001509897, 8481.236688698016, 8149.674013039486, 8298.336133109351, 8304.252617264445, 8336.70821521247, 8342.165783421655, 2142.700021996922, 2338.53229354129, 2402.5074859653773, 2403.819713521484, 2441.40185654514, 2412.7949124324455, 2419.0, 2421.4430680943306, 2423.018677435641, 2423.987880060606, 2304.446932736148, 2371.893264803088, 2372.893219805113, 2374.8812559371963, 2375.1212051540956, 2070.4823794051413, 2333.4516388648653, 2386.85678859269, 2387.713474383068, 2392.4018995251186, 2309.411100169446, 2342.2153578551206, 2363.645453182019, 2372.3120295114395, 2372.715274167094, 8544.060153383123, 8560.828783424358, 8578.099299573518, 8584.141585841428, 8586.828263434696, 5148.742562871841, 5205.687658740488, 5253.947460525423, 5265.052290587692, 5318.627696061278, 3410.7100896423835, 3422.26421319415, 3478.565179352581, 3521.506989021539, 3569.303985722785, 1172.0857730969772, 1189.9226550274204, 1205.5780476833127, 1252.204849920298, 1310.9016823738257, 12384.81422778659, 12565.0, 12667.30329831859, 12668.2399056056, 12693.301868397235, 4537.455505339381, 4688.5545873142, 4717.858464246078, 4729.314249433813, 4752.500987396343, 10796.78406431867, 10805.945970270099, 10831.729206769895, 10844.620438284623, 10847.945760271306, 4835.758212089381, 5413.53984911287, 5417.133258678593, 5419.701916394636, 5424.213489044067, 4767.022760334124, 4782.3543821584335, 4795.448523419782, 4816.422029356429, 4842.733649649233, 4078.1028173801715, 4101.2207680540605, 4122.416637180438, 4161.146964872194, 4211.136716973013, 1288.6327396691897, 1300.460308971785, 1304.1327517201146, 1312.553731731216, 1331.4807225182187, 880.55972013993, 991.4051569058507, 1025.236199031726, 1049.9580016799243, 1099.9945000275106, 5892.911606325909, 5943.257092863392, 5954.49386802118, 5967.492763115097, 6117.84705382369, 988.1008282462924, 1002.2983911262146, 1057.7249915021996, 1091.8307662312195, 1092.82514797632, 4006.819693113817, 4097.487814023247, 4365.563443655673, 4491.932621010622, 4592.3800286961505, 11003.119750419946, 11212.0, 11311.038561722346, 11337.546498139982, 11390.772184556428, 10903.0, 10907.509162087725, 11074.335539867634, 11093.944530277297, 11113.277636953571, 8159.510429374138, 8345.4158208926, 8384.329253659693, 8418.494890306602, 8421.873671894926, 6053.818385448443, 6154.599951003171, 6216.285127210429, 6241.188645476059, 6357.396047375492, 9678.0, 9732.805343893224, 9770.706878793648, 9776.560054797408, 9835.803283934138, 9751.414915105117, 10061.798764024825, 10070.345427547187, 10078.546465408928, 10158.542865570918, 7008.5094043416475, 7581.848363032819, 7818.648160832662, 7874.37005039584, 7989.680412783424, 8340.916590834015, 8366.24703776663, 8385.95807020961, 8411.831763364577, 8431.704890328809, 7176.0, 7218.530795498275, 7383.335499805044, 7480.663370148248, 7518.248175182657, 7447.664855081426, 7645.1972542882195, 7647.082350117799, 7750.457467977188, 7757.495762775401, 7134.821629459305, 7137.678804453708, 7181.533200341961, 7186.1376634804155, 7198.388137008204, 5376.112941364631, 5426.213199086189, 5514.944850551443, 5581.665100093845, 5588.580856435702, 5180.6891586504935, 5196.662216955886, 5211.218317252443, 5374.3013408256675, 5375.973120134531], "value": 4721.983393025184, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.7116137798737, 331.8075516200604, 342.912557297889, 353.1506726323193, 354.9024018394942, 6252.562320637558, 6256.311805701375, 6332.841678958022, 6378.298387177419, 6414.967925160379, 5913.172155898167, 6143.109249158881, 6283.7486500540035, 6301.495880329574, 6313.0, 4788.305695674125, 4818.807247710096, 4828.97585512072, 4829.22732362822, 4838.153323168449, 4812.663113582051, 4829.541193586604, 4840.177169881111, 4847.806087756486, 4853.466118726938, 4576.908461830762, 4653.302004699289, 4788.78450469728, 4802.23164293713, 4812.350332705092, 4758.904821903578, 4763.7141771493825, 4774.832880849171, 4775.856724298276, 4783.808647654089, 4233.9364909526075, 4235.49174099107, 4238.597333253336, 4245.469316335458, 4250.489941207075, 6003.339632640406, 6011.9098213526395, 6023.728932198062, 6029.246344206974, 6034.2155519782145, 5613.691246981414, 5614.1859430382365, 5619.971900140514, 5626.156076588503, 5630.831075067755, 6503.837404064889, 6609.239937407212, 6615.801525954229, 6618.238902526223, 6622.503312251552, 4688.976555117202, 4701.623870090384, 4708.293755936603, 4709.929351059703, 4711.434627844681, 6860.931390686079, 6872.072270243503, 6874.278200788895, 6886.724531018804, 6889.862202755917, 4822.180229361017, 4825.927611085836, 4832.202686556679, 4835.2505361669, 4841.757912104381, 4895.657303988758, 4902.7058376497525, 4907.9263811042865, 4908.631852611068, 4910.779014944336, 5299.417064122943, 5442.537384322377, 5444.646098003617, 5589.133684278943, 5606.887862242814, 6549.083128362033, 6559.737610495622, 6642.701078451481, 6668.799936001928, 6672.766453174116, 1590.157216675164, 1631.5594789406794, 1637.0341498515934, 1671.1310118738188, 1679.6892574873686, 1083.268793564341, 1096.742265567591, 1099.934003959749, 1102.8014957307762, 1104.8950349716924, 6323.936760632427, 6355.332690067568, 6355.809325720235, 6356.491480681627, 6368.745250190033, 6794.898076528757, 6803.591784492946, 6810.761623343159, 6819.693113809891, 6831.180258369028, 6291.96854015727, 6300.243970723451, 6300.653464059429, 6327.303996560375, 6328.936710632835, 3641.1443310821937, 3669.1010702377553, 3671.0638787109115, 3674.669279764834, 3674.797886116236, 6975.930240697629, 7058.505904586629, 7207.711691532385, 7218.8917166242545, 7233.095863017123, 6993.0, 6996.160460744642, 6997.825054373579, 7011.053507776385, 7036.050133232051, 7189.748358807521, 7208.56748595086, 7215.124067742425, 7216.67524961378, 7221.386182174469, 6940.0, 7004.859902801813, 7021.403180729695, 7035.366816986496, 7038.0, 6582.80251592453, 6746.156730408699, 6866.038754574263, 6872.244053154049, 6888.758893438706, 7192.964035179791, 7211.495195336276, 7212.639368031472, 7218.205997340393, 7221.927780722125, 4713.81144754206, 4747.311639812277, 4757.904841903073, 4759.905221799075, 4766.713997160182, 6636.336366363518, 6900.0, 6903.309669033057, 6919.065926099912, 6919.169699636076, 6483.870322593616, 6611.074449576967, 6665.200175978914, 6753.966230168818, 6754.628495432602, 6666.333366663295, 6693.263740988585, 6699.76550820719, 6702.329767023259, 6703.731850725916, 6575.112359831362, 6589.044588534732, 6594.934050659432, 6599.241087275025, 6601.405873471411, 6603.471722262111, 6702.229243636849, 6703.731850725916, 6730.899036514554, 6747.898781518183, 6507.219133703986, 6547.345265473415, 6553.606783593, 6572.638504882086, 6578.079068930258], "value": 5024.916502108761, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.6046976511744, 819.0458116294514, 860.2945584620612, 936.3632729743772, 941.2422999485411, 15351.769723454157, 15732.685346293067, 15810.051396916193, 15861.127637979907, 15866.286017129229, 15101.471448499306, 15951.282192301345, 15956.840431595681, 16024.278907449163, 16026.0, 736.7310931509987, 889.1553024626614, 898.0794685447436, 901.6663834381255, 914.6158613382395, 900.2078171209326, 904.1230006893303, 904.2856143646544, 905.3933864310894, 907.3285768531306, 955.7180631713626, 956.5121787888193, 958.4249450329816, 958.6644674363952, 959.0217977662779, 772.7527191298786, 940.7836197674538, 949.2216382566298, 952.3761935931975, 955.6702937486556, 695.9095317608729, 700.6846918886522, 700.7547358424562, 701.253165378875, 701.3687681087011, 15563.766543501857, 16017.839821601752, 16042.438514652047, 16058.27737751804, 16062.5984350391, 14185.43258269668, 14519.346629401702, 14713.779293310608, 14825.258737063104, 14891.776623350659, 12000.699982500508, 12021.066819758915, 12036.277823330629, 12109.878901210963, 12178.208416452992, 3956.6636835868985, 3983.8008099594904, 4018.9196216075807, 4025.657819085381, 4041.7372870763306, 59893.10160347598, 59926.70036649789, 60261.69869150626, 60445.39554604442, 60572.0, 11031.613893513688, 11479.71300717472, 11557.88442115568, 11778.411079445994, 12006.819897701542, 20375.28686495995, 20376.592468150553, 20434.79565204329, 20474.38576842697, 20515.8974205131, 8721.869171962426, 8808.471491710518, 8817.691380801642, 8829.779255518664, 9124.908750912538, 5197.896042079213, 5296.576273898079, 5328.280682107943, 5372.516473517324, 5409.540189083893, 3644.0889777555612, 3704.6110158433517, 3707.4068149096015, 3710.109573702346, 3711.31340701971, 611.7981066248217, 623.5697368815503, 654.8002859127917, 669.8459354348527, 671.1845108193568, 621.0683974038942, 654.450261780107, 732.1763016606318, 764.3312101910828, 781.620913856779, 9505.66730164441, 9834.516307132157, 9890.357126786736, 9965.103140717225, 10195.439250841275, 724.713738073458, 740.4335683202354, 748.644393912887, 757.2124990010437, 765.2462324610254, 4554.294084416921, 4560.908781824345, 4626.7223966562115, 4684.0866031123605, 4687.484376718558, 70044.0, 70529.2947070533, 71260.28739712537, 71502.64248678827, 71503.0, 63152.68423657852, 63587.36412635907, 64088.0, 64827.675861621334, 64898.0, 54984.725076375165, 55384.0, 56237.437625624036, 56602.43397566054, 57989.13016304759, 9098.408603440756, 9171.128742769426, 9216.815663686823, 9221.0, 9228.169464747936, 40561.59438405578, 41139.0, 41286.58713412828, 42588.0, 43499.565004350814, 49118.508814911394, 50348.49651503438, 54493.45506544884, 54675.0, 55528.0, 12723.300218487702, 13098.148620339647, 13387.0, 13577.321133943065, 13782.241976691379, 14278.571642850731, 14640.26798660084, 14815.629609259855, 14831.406743730562, 14992.47526336573, 10850.565977360817, 13359.332033398485, 13563.86436135626, 13968.231747253592, 14192.290385480892, 13136.080474366703, 13332.93333533326, 13475.460981560627, 13506.797398039234, 13600.86399135996, 14398.352074156479, 14567.125972441687, 14601.342939567532, 14822.851771482146, 15102.471413500474, 11963.342016189194, 12054.337011464102, 12092.758144836878, 12300.692482687646, 12425.19236249641, 11911.3448760319, 11944.0, 12021.75956480883, 12123.45444454984, 12276.508939642314], "value": 7380.648193468595, "unit": "score"}], "name": "dromaeo_css", "value": 7685.876076911134, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 109.0, 109.0, 108.0, 110.0, 106.0, 109.0, 109.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 156.0, 173.0, 132.0, 160.0, 154.0, 127.0, 176.0, 127.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 162.0, 160.0, 160.0, 162.0, 158.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 165.0, 76.0, 73.0, 77.0, 74.0, 160.0, 75.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 162.0, 91.0, 93.0, 91.0, 156.0, 92.0, 92.0, 145.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 55.0, 54.0, 54.0, 56.0, 74.0, 53.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 58.0, 57.0, 58.0, 60.0, 58.0, 58.0, 60.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 72.0, 72.0, 71.0, 72.0, 72.0, 72.0, 72.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 137.0, 120.0, 114.0, 114.0, 113.0, 110.0, 119.0, 162.0, 123.0], "value": 122.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 155.0, 152.0, 156.0, 154.0, 159.0, 158.0, 155.0, 157.0, 154.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 67.0, 68.0, 68.0, 64.0, 66.0, 67.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1508.4999999999998, "alertThreshold": 2.0}]} 20:04:05 INFO - Return code: 0 20:04:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:04:05 ERROR - # TBPL SUCCESS # 20:04:05 INFO - Running post-action listener: _resource_record_post_action 20:04:05 INFO - Running post-run listener: _resource_record_post_run 20:04:06 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 500256768; Read time: 32; Write time: 414340 20:04:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248750080; Read time: 0; Write time: 274732 20:04:06 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251506688; Read time: 32; Write time: 139608 20:04:06 INFO - Running post-run listener: _upload_blobber_files 20:04:06 INFO - Blob upload gear active. 20:04:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:04:06 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 20:04:06 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:04:06 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:04:07 INFO - (blobuploader) - INFO - Open directory for files ... 20:04:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:04:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:04:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:04:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:04:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:04:08 INFO - (blobuploader) - INFO - Done attempting. 20:04:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:04:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:04:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:04:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:04:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:04:08 INFO - (blobuploader) - INFO - Done attempting. 20:04:08 INFO - (blobuploader) - INFO - Iteration through files over. 20:04:08 INFO - Return code: 0 20:04:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:04:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:04:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13436a11d4af303ae6f90afde7e1e694858d674d39c16c3a67cf9340f0f0c1740b7dba26c05d719269b9e1c8c0b3fd1eadeea736fbb0fc61e34d8c10207b5b24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a42092c5acec5f031bf9a2672e27db7095c16dc2606509d5a0f0992757c6a31d2b3dec2487142c2dbb7ae540e56f7a948ba31fdcd314af98dd799df2c0d58d"} 20:04:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:04:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:04:08 INFO - Contents: 20:04:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13436a11d4af303ae6f90afde7e1e694858d674d39c16c3a67cf9340f0f0c1740b7dba26c05d719269b9e1c8c0b3fd1eadeea736fbb0fc61e34d8c10207b5b24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a42092c5acec5f031bf9a2672e27db7095c16dc2606509d5a0f0992757c6a31d2b3dec2487142c2dbb7ae540e56f7a948ba31fdcd314af98dd799df2c0d58d"} 20:04:08 INFO - Running post-run listener: copy_logs_to_upload_dir 20:04:08 INFO - Copying logs to upload dir... 20:04:08 INFO - mkdir: /builds/slave/test/build/upload/logs 20:04:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.042157 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-13 20:04:08.892197) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 20:04:08.895949) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13436a11d4af303ae6f90afde7e1e694858d674d39c16c3a67cf9340f0f0c1740b7dba26c05d719269b9e1c8c0b3fd1eadeea736fbb0fc61e34d8c10207b5b24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a42092c5acec5f031bf9a2672e27db7095c16dc2606509d5a0f0992757c6a31d2b3dec2487142c2dbb7ae540e56f7a948ba31fdcd314af98dd799df2c0d58d"} build_url:https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011732 build_url: 'https://queue.taskcluster.net/v1/task/R0Ko5MAbQdqeqoJ3GOb33w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13436a11d4af303ae6f90afde7e1e694858d674d39c16c3a67cf9340f0f0c1740b7dba26c05d719269b9e1c8c0b3fd1eadeea736fbb0fc61e34d8c10207b5b24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a42092c5acec5f031bf9a2672e27db7095c16dc2606509d5a0f0992757c6a31d2b3dec2487142c2dbb7ae540e56f7a948ba31fdcd314af98dd799df2c0d58d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 20:04:08.921758) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 20:04:08.922064) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1463192683.964652-595150704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 20:04:09.007341) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 20:04:09.007688) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 20:04:09.008003) ========= ========= Total master_lag: 0.17 =========