builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1463433821.83 results: success (0) buildid: 20160516112749 builduid: 1758f73ee6174a33b2368929ed4ff360 revision: 851cf3bbd1d555d076a280f5c491386a95957866 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:41.827751) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:41.828228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:41.828684) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:41.873999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:41.874302) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 14:23:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.1M=0s 2016-05-16 14:23:42 (51.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114515 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:42.013596) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:42.014333) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020469 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:42.077841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:42.078524) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 851cf3bbd1d555d076a280f5c491386a95957866 --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-beta --rev 851cf3bbd1d555d076a280f5c491386a95957866 --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=c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 14:23:42,395 truncating revision to first 12 chars 2016-05-16 14:23:42,395 Setting DEBUG logging. 2016-05-16 14:23:42,395 attempt 1/10 2016-05-16 14:23:42,395 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/851cf3bbd1d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 14:23:42,760 unpacking tar archive at: mozilla-beta-851cf3bbd1d5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653670 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:42.748155) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:42.748494) ========= script_repo_revision: 851cf3bbd1d555d076a280f5c491386a95957866 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:42.748918) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:42.749232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 14:23:42.759525) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-16 14:23:42.759828) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:23:43 INFO - MultiFileLogger online at 20160516 14:23:43 in /builds/slave/test 14:23:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:23:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:43 INFO - {'append_to_log': False, 14:23:43 INFO - 'base_work_dir': '/builds/slave/test', 14:23:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:23:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:43 INFO - 'branch': 'Mozilla-Beta', 14:23:43 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:43 INFO - 'config_files': ('talos/linux_config.py',), 14:23:43 INFO - 'default_actions': ('clobber', 14:23:43 INFO - 'read-buildbot-config', 14:23:43 INFO - 'download-and-extract', 14:23:43 INFO - 'populate-webroot', 14:23:43 INFO - 'create-virtualenv', 14:23:43 INFO - 'install', 14:23:43 INFO - 'run-tests'), 14:23:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:43 INFO - 'download_minidump_stackwalk': True, 14:23:43 INFO - 'download_symbols': 'ondemand', 14:23:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:43 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:43 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:43 INFO - 'installer_path': 'installer.exe', 14:23:43 INFO - 'log_level': 'info', 14:23:43 INFO - 'log_name': 'talos', 14:23:43 INFO - 'log_to_console': True, 14:23:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:23:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:23:43 INFO - 'opt_config_files': (), 14:23:43 INFO - 'pip_index': False, 14:23:43 INFO - 'sps_profile': False, 14:23:43 INFO - 'sps_profile_interval': 0, 14:23:43 INFO - 'suite': 'dromaeojs', 14:23:43 INFO - 'system_bits': '32', 14:23:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:43 INFO - 'title': 'talos-linux64-ix-004', 14:23:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:43 INFO - 'use_talos_json': True, 14:23:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:43 INFO - 'work_dir': 'build'} 14:23:43 INFO - ##### 14:23:43 INFO - ##### Running clobber step. 14:23:43 INFO - ##### 14:23:43 INFO - Running pre-action listener: _resource_record_pre_action 14:23:43 INFO - Running main action method: clobber 14:23:43 INFO - rmtree: /builds/slave/test/build 14:23:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:44 INFO - Running post-action listener: _resource_record_post_action 14:23:44 INFO - ##### 14:23:44 INFO - ##### Running read-buildbot-config step. 14:23:44 INFO - ##### 14:23:44 INFO - Running pre-action listener: _resource_record_pre_action 14:23:44 INFO - Running main action method: read_buildbot_config 14:23:44 INFO - Using buildbot properties: 14:23:44 INFO - { 14:23:44 INFO - "project": "", 14:23:44 INFO - "product": "firefox", 14:23:44 INFO - "script_repo_revision": "production", 14:23:44 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:23:44 INFO - "repository": "", 14:23:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:23:44 INFO - "buildid": "20160516112749", 14:23:44 INFO - "pgo_build": "True", 14:23:44 INFO - "basedir": "/builds/slave/test", 14:23:44 INFO - "buildnumber": 96, 14:23:44 INFO - "slavename": "talos-linux64-ix-004", 14:23:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:23:44 INFO - "platform": "ubuntu64_hw", 14:23:44 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:23:44 INFO - "branch": "mozilla-beta", 14:23:44 INFO - "repo_path": "releases/mozilla-beta", 14:23:44 INFO - "revision": "851cf3bbd1d555d076a280f5c491386a95957866", 14:23:44 INFO - "stage_platform": "linux64-pgo", 14:23:44 INFO - "builduid": "1758f73ee6174a33b2368929ed4ff360", 14:23:44 INFO - "slavebuilddir": "test" 14:23:44 INFO - } 14:23:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 14:23:44 INFO - Running post-action listener: _resource_record_post_action 14:23:44 INFO - ##### 14:23:44 INFO - ##### Running download-and-extract step. 14:23:44 INFO - ##### 14:23:44 INFO - Running pre-action listener: _resource_record_pre_action 14:23:44 INFO - Running main action method: download_and_extract 14:23:44 INFO - mkdir: /builds/slave/test/build/tests 14:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:44 INFO - https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:23:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:23:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:23:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:23:50 INFO - Downloaded 1412 bytes. 14:23:50 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:23:50 INFO - Using the following test package requirements: 14:23:50 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:23:50 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:23:50 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:23:50 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:23:50 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 14:23:50 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:23:50 INFO - u'jsshell-linux-x86_64.zip'], 14:23:50 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:23:50 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:23:50 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:23:50 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:23:50 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 14:23:50 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:23:50 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 14:23:50 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:23:50 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:23:50 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:23:50 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:23:50 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:23:50 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:50 INFO - https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:23:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:23:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:23:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:23:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:23:53 INFO - Downloaded 23364682 bytes. 14:23:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:23:54 INFO - Return code: 0 14:23:54 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:23:54 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')]} 14:23:54 INFO - https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:23:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:23:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:23:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:23:57 INFO - Downloaded 23364682 bytes. 14:23:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:23:58 INFO - Return code: 0 14:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:58 INFO - https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:23:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:23:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:23:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:24:00 INFO - Downloaded 10845194 bytes. 14:24:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:24:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:24:01 INFO - Return code: 0 14:24: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')]} 14:24:01 INFO - https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:24:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:24:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:24:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:24:03 INFO - Downloaded 53799043 bytes. 14:24:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:24:03 INFO - mkdir: /builds/slave/test/properties 14:24:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:24:03 INFO - Writing to file /builds/slave/test/properties/build_url 14:24:03 INFO - Contents: 14:24:03 INFO - build_url:https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:24:04 INFO - Running post-action listener: _resource_record_post_action 14:24:04 INFO - Running post-action listener: set_extra_try_arguments 14:24:04 INFO - ##### 14:24:04 INFO - ##### Running populate-webroot step. 14:24:04 INFO - ##### 14:24:04 INFO - Running pre-action listener: _resource_record_pre_action 14:24:04 INFO - Running main action method: populate_webroot 14:24:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:24:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:24:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:24:04 INFO - '--tppagecycles', 14:24:04 INFO - '7'], 14:24:04 INFO - 'tests': ['tsvgm']}}, 14:24:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:24:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:24:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:24:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:24:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:24:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:24:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:04 INFO - 'talos_options': ['--e10s'], 14:24:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:04 INFO - 'tests': ['damp', 'tps']}, 14:24:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:04 INFO - 'talos_options': ['--e10s'], 14:24:04 INFO - 'tests': ['damp', 'tps']}, 14:24:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:24:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:04 INFO - 'other': {'tests': ['a11yr', 14:24:04 INFO - 'ts_paint', 14:24:04 INFO - 'tpaint', 14:24:04 INFO - 'sessionrestore', 14:24:04 INFO - 'sessionrestore_no_auto_restore', 14:24:04 INFO - 'tabpaint']}, 14:24:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:24:04 INFO - 'tests': ['a11yr', 14:24:04 INFO - 'ts_paint', 14:24:04 INFO - 'tpaint', 14:24:04 INFO - 'sessionrestore', 14:24:04 INFO - 'sessionrestore_no_auto_restore', 14:24:04 INFO - 'tabpaint']}, 14:24:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:24:04 INFO - 'tests': ['a11yr', 14:24:04 INFO - 'ts_paint', 14:24:04 INFO - 'tpaint', 14:24:04 INFO - 'sessionrestore', 14:24:04 INFO - 'sessionrestore_no_auto_restore', 14:24:04 INFO - 'tabpaint']}, 14:24:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:24:04 INFO - 'tests': ['a11yr', 14:24:04 INFO - 'ts_paint', 14:24:04 INFO - 'tpaint', 14:24:04 INFO - 'sessionrestore', 14:24:04 INFO - 'sessionrestore_no_auto_restore', 14:24:04 INFO - 'tabpaint']}, 14:24:04 INFO - 'other_l64': {'tests': ['a11yr', 14:24:04 INFO - 'ts_paint', 14:24:04 INFO - 'tpaint', 14:24:04 INFO - 'sessionrestore', 14:24:04 INFO - 'sessionrestore_no_auto_restore', 14:24:04 INFO - 'tabpaint']}, 14:24:04 INFO - 'other_nol64': {'tests': ['a11yr', 14:24:04 INFO - 'ts_paint', 14:24:04 INFO - 'tpaint', 14:24:04 INFO - 'sessionrestore', 14:24:04 INFO - 'sessionrestore_no_auto_restore', 14:24:04 INFO - 'tabpaint']}, 14:24:04 INFO - 'svgr': {'tests': ['tsvgx', 14:24:04 INFO - 'tsvgr_opacity', 14:24:04 INFO - 'tart', 14:24:04 INFO - 'tscrollx', 14:24:04 INFO - 'cart']}, 14:24:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:24:04 INFO - 'tests': ['tsvgx', 14:24:04 INFO - 'tsvgr_opacity', 14:24:04 INFO - 'tart', 14:24:04 INFO - 'tscrollx', 14:24:04 INFO - 'cart']}, 14:24:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:04 INFO - 'tests': ['tp5o']}, 14:24:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:04 INFO - 'talos_options': ['--e10s'], 14:24:04 INFO - 'tests': ['tp5o']}, 14:24:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:04 INFO - 'talos_options': ['--xperf_path', 14:24:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:04 INFO - 'tests': ['tp5n']}, 14:24:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:04 INFO - 'talos_options': ['--e10s', 14:24:04 INFO - '--xperf_path', 14:24:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:04 INFO - 'tests': ['tp5n']}}, 14:24:04 INFO - 'talos.zip': {'path': '', 14:24:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:24:04 INFO - Running post-action listener: _resource_record_post_action 14:24:04 INFO - ##### 14:24:04 INFO - ##### Running create-virtualenv step. 14:24:04 INFO - ##### 14:24:04 INFO - Running pre-action listener: _resource_record_pre_action 14:24:04 INFO - Running main action method: create_virtualenv 14:24:04 INFO - Creating virtualenv /builds/slave/test/build/venv 14:24:04 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 14:24:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:24:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:04 INFO - Using real prefix '/usr' 14:24:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:24:04 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:06 INFO - Installing pip.................done. 14:24:06 INFO - Return code: 0 14:24:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:06 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 0x7f155eeabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f29160>, '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 0x1f2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', '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 14:24:06 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 14:24:06 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 14:24:06 INFO - Using env: {'DISPLAY': ':0', 14:24:06 INFO - 'HOME': '/home/cltbld', 14:24:06 INFO - 'LANG': 'en_US.UTF-8', 14:24:06 INFO - 'LANGUAGE': 'en_US:en', 14:24:06 INFO - 'LOGNAME': 'cltbld', 14:24:06 INFO - 'MAIL': '/var/mail/cltbld', 14:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:06 INFO - 'MOZ_NO_REMOTE': '1', 14:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:06 INFO - 'NO_EM_RESTART': '1', 14:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:06 INFO - 'PWD': '/builds/slave/test', 14:24:06 INFO - 'SHELL': '/bin/bash', 14:24:06 INFO - 'SHLVL': '1', 14:24:06 INFO - 'TERM': 'linux', 14:24:06 INFO - 'TMOUT': '86400', 14:24:06 INFO - 'USER': 'cltbld', 14:24:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', 14:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:06 INFO - '_': '/tools/buildbot/bin/python'} 14:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:06 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 14:24:06 INFO - Cleaning up... 14:24:06 INFO - Return code: 0 14:24:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:06 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 0x7f155eeabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f29160>, '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 0x1f2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', '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 14:24:06 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 14:24:06 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 14:24:06 INFO - Using env: {'DISPLAY': ':0', 14:24:06 INFO - 'HOME': '/home/cltbld', 14:24:06 INFO - 'LANG': 'en_US.UTF-8', 14:24:06 INFO - 'LANGUAGE': 'en_US:en', 14:24:06 INFO - 'LOGNAME': 'cltbld', 14:24:06 INFO - 'MAIL': '/var/mail/cltbld', 14:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:06 INFO - 'MOZ_NO_REMOTE': '1', 14:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:06 INFO - 'NO_EM_RESTART': '1', 14:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:06 INFO - 'PWD': '/builds/slave/test', 14:24:06 INFO - 'SHELL': '/bin/bash', 14:24:06 INFO - 'SHLVL': '1', 14:24:06 INFO - 'TERM': 'linux', 14:24:06 INFO - 'TMOUT': '86400', 14:24:06 INFO - 'USER': 'cltbld', 14:24:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', 14:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:06 INFO - '_': '/tools/buildbot/bin/python'} 14:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:07 INFO - Downloading/unpacking psutil>=0.7.1 14:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:09 INFO - Installing collected packages: psutil 14:24:09 INFO - Running setup.py install for psutil 14:24:09 INFO - building 'psutil._psutil_linux' extension 14:24:09 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 14:24:09 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 14:24:09 INFO - building 'psutil._psutil_posix' extension 14:24:09 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 14:24:09 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 14:24:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:09 INFO - Successfully installed psutil 14:24:09 INFO - Cleaning up... 14:24:09 INFO - Return code: 0 14:24:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f155eeabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f29160>, '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 0x1f2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', '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 14:24:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:24:09 INFO - Using env: {'DISPLAY': ':0', 14:24:09 INFO - 'HOME': '/home/cltbld', 14:24:09 INFO - 'LANG': 'en_US.UTF-8', 14:24:09 INFO - 'LANGUAGE': 'en_US:en', 14:24:09 INFO - 'LOGNAME': 'cltbld', 14:24:09 INFO - 'MAIL': '/var/mail/cltbld', 14:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:09 INFO - 'MOZ_NO_REMOTE': '1', 14:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:09 INFO - 'NO_EM_RESTART': '1', 14:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:09 INFO - 'PWD': '/builds/slave/test', 14:24:09 INFO - 'SHELL': '/bin/bash', 14:24:09 INFO - 'SHLVL': '1', 14:24:09 INFO - 'TERM': 'linux', 14:24:09 INFO - 'TMOUT': '86400', 14:24:09 INFO - 'USER': 'cltbld', 14:24:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', 14:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:09 INFO - '_': '/tools/buildbot/bin/python'} 14:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:24:11 INFO - Installing collected packages: mozsystemmonitor 14:24:11 INFO - Running setup.py install for mozsystemmonitor 14:24:11 INFO - Successfully installed mozsystemmonitor 14:24:11 INFO - Cleaning up... 14:24:12 INFO - Return code: 0 14:24:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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', '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 0x7f155eeabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f29160>, '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 0x1f2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', '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 14:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:24: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 blobuploader==1.2.4 14:24:12 INFO - Using env: {'DISPLAY': ':0', 14:24:12 INFO - 'HOME': '/home/cltbld', 14:24:12 INFO - 'LANG': 'en_US.UTF-8', 14:24:12 INFO - 'LANGUAGE': 'en_US:en', 14:24:12 INFO - 'LOGNAME': 'cltbld', 14:24:12 INFO - 'MAIL': '/var/mail/cltbld', 14:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:12 INFO - 'MOZ_NO_REMOTE': '1', 14:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:12 INFO - 'NO_EM_RESTART': '1', 14:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:12 INFO - 'PWD': '/builds/slave/test', 14:24:12 INFO - 'SHELL': '/bin/bash', 14:24:12 INFO - 'SHLVL': '1', 14:24:12 INFO - 'TERM': 'linux', 14:24:12 INFO - 'TMOUT': '86400', 14:24:12 INFO - 'USER': 'cltbld', 14:24:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', 14:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:12 INFO - '_': '/tools/buildbot/bin/python'} 14:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:12 INFO - Downloading/unpacking blobuploader==1.2.4 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:14 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:15 INFO - Downloading docopt-0.6.1.tar.gz 14:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:15 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:15 INFO - Running setup.py install for blobuploader 14:24:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:15 INFO - Running setup.py install for requests 14:24:15 INFO - Running setup.py install for docopt 14:24:15 INFO - Successfully installed blobuploader requests docopt 14:24:15 INFO - Cleaning up... 14:24:15 INFO - Return code: 0 14:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:15 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 0x7f155eeabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f29160>, '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 0x1f2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', '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 14:24:15 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 14:24:15 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 14:24:15 INFO - Using env: {'DISPLAY': ':0', 14:24:15 INFO - 'HOME': '/home/cltbld', 14:24:15 INFO - 'LANG': 'en_US.UTF-8', 14:24:15 INFO - 'LANGUAGE': 'en_US:en', 14:24:15 INFO - 'LOGNAME': 'cltbld', 14:24:15 INFO - 'MAIL': '/var/mail/cltbld', 14:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:15 INFO - 'MOZ_NO_REMOTE': '1', 14:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:15 INFO - 'NO_EM_RESTART': '1', 14:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:15 INFO - 'PWD': '/builds/slave/test', 14:24:15 INFO - 'SHELL': '/bin/bash', 14:24:15 INFO - 'SHLVL': '1', 14:24:15 INFO - 'TERM': 'linux', 14:24:15 INFO - 'TMOUT': '86400', 14:24:15 INFO - 'USER': 'cltbld', 14:24:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', 14:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:15 INFO - '_': '/tools/buildbot/bin/python'} 14:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:15 INFO - Running setup.py (path:/tmp/pip-H6KQ2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:15 INFO - Running setup.py (path:/tmp/pip-Luhc1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:16 INFO - Running setup.py (path:/tmp/pip-HA0o97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:16 INFO - Running setup.py (path:/tmp/pip-57eHAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:16 INFO - Running setup.py (path:/tmp/pip-b4TBYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:16 INFO - Running setup.py (path:/tmp/pip-vxkS_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:16 INFO - Running setup.py (path:/tmp/pip-6SzlFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:16 INFO - Running setup.py (path:/tmp/pip-UEQ1m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:16 INFO - Running setup.py (path:/tmp/pip-zN5FZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:16 INFO - Running setup.py (path:/tmp/pip-AL00mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:16 INFO - Running setup.py (path:/tmp/pip-_Gurdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:16 INFO - Running setup.py (path:/tmp/pip-fezpif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:16 INFO - Running setup.py (path:/tmp/pip-HP3JEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:16 INFO - Running setup.py (path:/tmp/pip-SFRglu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:16 INFO - Running setup.py (path:/tmp/pip-cziHs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:16 INFO - Running setup.py (path:/tmp/pip-H7nDYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:17 INFO - Running setup.py (path:/tmp/pip-m1kh7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:17 INFO - Running setup.py install for manifestparser 14:24:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:17 INFO - Running setup.py install for mozcrash 14:24:17 INFO - Running setup.py install for mozdebug 14:24:17 INFO - Running setup.py install for mozdevice 14:24:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:24:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:17 INFO - Running setup.py install for mozfile 14:24:17 INFO - Running setup.py install for mozhttpd 14:24:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:17 INFO - Running setup.py install for mozinfo 14:24:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:17 INFO - Running setup.py install for mozInstall 14:24:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:17 INFO - Running setup.py install for mozleak 14:24:18 INFO - Running setup.py install for mozlog 14:24:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:18 INFO - Running setup.py install for moznetwork 14:24:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:18 INFO - Running setup.py install for mozprocess 14:24:18 INFO - Running setup.py install for mozprofile 14:24:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:18 INFO - Running setup.py install for mozrunner 14:24:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:18 INFO - Running setup.py install for mozscreenshot 14:24:18 INFO - Running setup.py install for moztest 14:24:18 INFO - Running setup.py install for mozversion 14:24:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:18 INFO - Cleaning up... 14:24:18 INFO - Return code: 0 14:24:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:18 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')]} 14:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:18 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')]} 14:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:18 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 0x7f155eeabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f29160>, '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 0x1f2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', '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 14:24:18 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 14:24:18 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 14:24:18 INFO - Using env: {'DISPLAY': ':0', 14:24:18 INFO - 'HOME': '/home/cltbld', 14:24:18 INFO - 'LANG': 'en_US.UTF-8', 14:24:18 INFO - 'LANGUAGE': 'en_US:en', 14:24:18 INFO - 'LOGNAME': 'cltbld', 14:24:18 INFO - 'MAIL': '/var/mail/cltbld', 14:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:18 INFO - 'MOZ_NO_REMOTE': '1', 14:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:18 INFO - 'NO_EM_RESTART': '1', 14:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:18 INFO - 'PWD': '/builds/slave/test', 14:24:18 INFO - 'SHELL': '/bin/bash', 14:24:18 INFO - 'SHLVL': '1', 14:24:18 INFO - 'TERM': 'linux', 14:24:18 INFO - 'TMOUT': '86400', 14:24:18 INFO - 'USER': 'cltbld', 14:24:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', 14:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:18 INFO - '_': '/tools/buildbot/bin/python'} 14:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:19 INFO - Running setup.py (path:/tmp/pip-396rfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:19 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)) 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:19 INFO - Running setup.py (path:/tmp/pip-qKPXg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:19 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)) 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:19 INFO - Running setup.py (path:/tmp/pip-sEFT8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:19 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)) 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:19 INFO - Running setup.py (path:/tmp/pip-He5uvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:19 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)) 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:19 INFO - Running setup.py (path:/tmp/pip-eWEY_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:19 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)) 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:19 INFO - Running setup.py (path:/tmp/pip-_nzaT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:19 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)) 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:19 INFO - Running setup.py (path:/tmp/pip-nBmSFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:19 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)) 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:19 INFO - Running setup.py (path:/tmp/pip-qqrxpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:19 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)) 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:19 INFO - Running setup.py (path:/tmp/pip-m5f4lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:19 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)) 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:19 INFO - Running setup.py (path:/tmp/pip-BahLQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:19 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)) 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:19 INFO - Running setup.py (path:/tmp/pip-V1cvz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:19 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)) 14:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:19 INFO - Running setup.py (path:/tmp/pip-ZdM6W3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:20 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)) 14:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:20 INFO - Running setup.py (path:/tmp/pip-vgF1RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:20 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)) 14:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:20 INFO - Running setup.py (path:/tmp/pip-1q5ltF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:20 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)) 14:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:20 INFO - Running setup.py (path:/tmp/pip-TYStz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:20 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)) 14:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:20 INFO - Running setup.py (path:/tmp/pip-cstgsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:20 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)) 14:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:20 INFO - Running setup.py (path:/tmp/pip-YqH46T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:20 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)) 14:24:20 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)) 14:24:20 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)) 14:24:20 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)) 14:24:20 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)) 14:24:20 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)) 14:24:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24:20 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 14:24:20 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 14:24:20 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 14:24:20 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 14:24:20 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 14:24:20 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 14:24:22 INFO - Downloading blessings-1.6.tar.gz 14:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:24:22 INFO - Installing collected packages: blessings 14:24:22 INFO - Running setup.py install for blessings 14:24:22 INFO - Successfully installed blessings 14:24:22 INFO - Cleaning up... 14:24:22 INFO - Return code: 0 14:24:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:24:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:22 INFO - Reading from file tmpfile_stdout 14:24:22 INFO - Current package versions: 14:24:22 INFO - argparse == 1.2.1 14:24:22 INFO - blessings == 1.6 14:24:22 INFO - blobuploader == 1.2.4 14:24:22 INFO - docopt == 0.6.1 14:24:22 INFO - manifestparser == 1.1 14:24:22 INFO - mozInstall == 1.12 14:24:22 INFO - mozcrash == 0.17 14:24:22 INFO - mozdebug == 0.1 14:24:22 INFO - mozdevice == 0.48 14:24:22 INFO - mozfile == 1.2 14:24:22 INFO - mozhttpd == 0.7 14:24:22 INFO - mozinfo == 0.9 14:24:22 INFO - mozleak == 0.1 14:24:22 INFO - mozlog == 3.1 14:24:22 INFO - moznetwork == 0.27 14:24:22 INFO - mozprocess == 0.22 14:24:22 INFO - mozprofile == 0.28 14:24:22 INFO - mozrunner == 6.11 14:24:22 INFO - mozscreenshot == 0.1 14:24:22 INFO - mozsystemmonitor == 0.0 14:24:22 INFO - moztest == 0.7 14:24:22 INFO - mozversion == 1.4 14:24:22 INFO - psutil == 3.1.1 14:24:22 INFO - requests == 1.2.3 14:24:22 INFO - wsgiref == 0.1.2 14:24:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:22 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')]} 14:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:22 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')]} 14:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:22 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 0x7f155eeabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f29160>, '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 0x1f2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', '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 14:24:22 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 14:24:22 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 14:24:22 INFO - Using env: {'DISPLAY': ':0', 14:24:22 INFO - 'HOME': '/home/cltbld', 14:24:22 INFO - 'LANG': 'en_US.UTF-8', 14:24:22 INFO - 'LANGUAGE': 'en_US:en', 14:24:22 INFO - 'LOGNAME': 'cltbld', 14:24:22 INFO - 'MAIL': '/var/mail/cltbld', 14:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:22 INFO - 'MOZ_NO_REMOTE': '1', 14:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:22 INFO - 'NO_EM_RESTART': '1', 14:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:22 INFO - 'PWD': '/builds/slave/test', 14:24:22 INFO - 'SHELL': '/bin/bash', 14:24:22 INFO - 'SHLVL': '1', 14:24:22 INFO - 'TERM': 'linux', 14:24:22 INFO - 'TMOUT': '86400', 14:24:22 INFO - 'USER': 'cltbld', 14:24:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', 14:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:22 INFO - '_': '/tools/buildbot/bin/python'} 14:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:22 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)) 14:24:22 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)) 14:24:22 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)) 14:24:22 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)) 14:24:22 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)) 14:24:22 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)) 14:24:22 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)) 14:24:22 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)) 14:24:22 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)) 14:24:22 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)) 14:24:22 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)) 14:24:22 INFO - Cleaning up... 14:24:23 INFO - Return code: 0 14:24:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f155eeabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f29160>, '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 0x1f2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', '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 14:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:24:23 INFO - Using env: {'DISPLAY': ':0', 14:24:23 INFO - 'HOME': '/home/cltbld', 14:24:23 INFO - 'LANG': 'en_US.UTF-8', 14:24:23 INFO - 'LANGUAGE': 'en_US:en', 14:24:23 INFO - 'LOGNAME': 'cltbld', 14:24:23 INFO - 'MAIL': '/var/mail/cltbld', 14:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:23 INFO - 'MOZ_NO_REMOTE': '1', 14:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:23 INFO - 'NO_EM_RESTART': '1', 14:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:23 INFO - 'PWD': '/builds/slave/test', 14:24:23 INFO - 'SHELL': '/bin/bash', 14:24:23 INFO - 'SHLVL': '1', 14:24:23 INFO - 'TERM': 'linux', 14:24:23 INFO - 'TMOUT': '86400', 14:24:23 INFO - 'USER': 'cltbld', 14:24:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', 14:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:23 INFO - '_': '/tools/buildbot/bin/python'} 14:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:23 INFO - Downloading/unpacking jsonschema 14:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:26 INFO - Downloading/unpacking functools32 (from jsonschema) 14:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:26 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:26 INFO - warning: no files found matching '*.txt' 14:24:26 INFO - no previously-included directories found matching 'build' 14:24:26 INFO - no previously-included directories found matching 'dist' 14:24:26 INFO - no previously-included directories found matching '.git*' 14:24:26 INFO - Installing collected packages: jsonschema, functools32 14:24:26 INFO - Running setup.py install for functools32 14:24:26 INFO - warning: no files found matching '*.txt' 14:24:26 INFO - no previously-included directories found matching 'build' 14:24:26 INFO - no previously-included directories found matching 'dist' 14:24:26 INFO - no previously-included directories found matching '.git*' 14:24:26 INFO - Successfully installed jsonschema functools32 14:24:26 INFO - Cleaning up... 14:24:26 INFO - Return code: 0 14:24:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:24:26 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')]} 14:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:26 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')]} 14:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f155eeabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f29160>, '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 0x1f2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', '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 14:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:24:26 INFO - Using env: {'DISPLAY': ':0', 14:24:26 INFO - 'HOME': '/home/cltbld', 14:24:26 INFO - 'LANG': 'en_US.UTF-8', 14:24:26 INFO - 'LANGUAGE': 'en_US:en', 14:24:26 INFO - 'LOGNAME': 'cltbld', 14:24:26 INFO - 'MAIL': '/var/mail/cltbld', 14:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:26 INFO - 'MOZ_NO_REMOTE': '1', 14:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:26 INFO - 'NO_EM_RESTART': '1', 14:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:26 INFO - 'PWD': '/builds/slave/test', 14:24:26 INFO - 'SHELL': '/bin/bash', 14:24:26 INFO - 'SHLVL': '1', 14:24:26 INFO - 'TERM': 'linux', 14:24:26 INFO - 'TMOUT': '86400', 14:24:26 INFO - 'USER': 'cltbld', 14:24:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', 14:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:26 INFO - '_': '/tools/buildbot/bin/python'} 14:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:26 INFO - Downloading/unpacking flake8 14:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:24:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:24:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:24:29 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 14:24:29 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 14:24:29 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 14:24:29 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 14:24:29 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 14:24:29 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 14:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:24:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:24:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:24:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:24:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:24:29 INFO - no previously-included directories found matching 'docs/_build' 14:24:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:24:29 INFO - Running setup.py install for pep8 14:24:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:24:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:24:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:24:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:24:29 INFO - no previously-included directories found matching 'docs/_build' 14:24:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:24:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:24:29 INFO - Cleaning up... 14:24:29 INFO - Return code: 0 14:24:29 INFO - Running post-action listener: _resource_record_post_action 14:24:29 INFO - Running post-action listener: _start_resource_monitoring 14:24:29 INFO - Starting resource monitoring. 14:24:29 INFO - ##### 14:24:29 INFO - ##### Running install step. 14:24:29 INFO - ##### 14:24:29 INFO - Running pre-action listener: _resource_record_pre_action 14:24:29 INFO - Running main action method: install 14:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:29 INFO - Reading from file tmpfile_stdout 14:24:29 INFO - Detecting whether we're running mozinstall >=1.0... 14:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:24:29 INFO - Reading from file tmpfile_stdout 14:24:29 INFO - Output received: 14:24:29 INFO - Usage: mozinstall [options] installer 14:24:29 INFO - Options: 14:24:29 INFO - -h, --help show this help message and exit 14:24:29 INFO - -d DEST, --destination=DEST 14:24:29 INFO - Directory to install application into. [default: 14:24:29 INFO - "/builds/slave/test"] 14:24:29 INFO - --app=APP Application being installed. [default: firefox] 14:24:29 INFO - mkdir: /builds/slave/test/build/application 14:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:24:42 INFO - Reading from file tmpfile_stdout 14:24:42 INFO - Output received: 14:24:42 INFO - /builds/slave/test/build/application/firefox/firefox 14:24:42 INFO - Running post-action listener: _resource_record_post_action 14:24:42 INFO - ##### 14:24:42 INFO - ##### Running run-tests step. 14:24:42 INFO - ##### 14:24:42 INFO - Running pre-action listener: _resource_record_pre_action 14:24:42 INFO - Running main action method: run_tests 14:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:24:42 INFO - Python 2.7.3 14:24:42 INFO - Return code: 0 14:24:42 INFO - grabbing minidump binary from tooltool 14:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:42 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 0x1f29160>, '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 0x1f2a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:24:42 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 14:24:42 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 14:24:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:24:42 INFO - Return code: 0 14:24:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:24:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:24:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:24:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:24:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:24:43 INFO - Return code: 0 14:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 14:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 14:24:43 INFO - Using env: {'DISPLAY': ':0', 14:24:43 INFO - 'HOME': '/home/cltbld', 14:24:43 INFO - 'LANG': 'en_US.UTF-8', 14:24:43 INFO - 'LANGUAGE': 'en_US:en', 14:24:43 INFO - 'LOGNAME': 'cltbld', 14:24:43 INFO - 'MAIL': '/var/mail/cltbld', 14:24:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:24:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:43 INFO - 'MOZ_NO_REMOTE': '1', 14:24:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:43 INFO - 'NO_EM_RESTART': '1', 14:24:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:43 INFO - 'PWD': '/builds/slave/test', 14:24:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:24:43 INFO - 'SHELL': '/bin/bash', 14:24:43 INFO - 'SHLVL': '1', 14:24:43 INFO - 'TERM': 'linux', 14:24:43 INFO - 'TMOUT': '86400', 14:24:43 INFO - 'USER': 'cltbld', 14:24:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525', 14:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:43 INFO - '_': '/tools/buildbot/bin/python'} 14:24:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 14:24:43 INFO - mozversion application_buildid: 20160516112749 14:24:43 INFO - mozversion application_changeset: 851cf3bbd1d555d076a280f5c491386a95957866 14:24:43 INFO - mozversion application_display_name: Firefox 14:24:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:24:43 INFO - mozversion application_name: Firefox 14:24:43 INFO - mozversion application_remotingname: firefox 14:24:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:24:43 INFO - mozversion application_vendor: Mozilla 14:24:43 INFO - mozversion application_version: 47.0 14:24:43 INFO - mozversion platform_buildid: 20160516112749 14:24:43 INFO - mozversion platform_changeset: 851cf3bbd1d555d076a280f5c491386a95957866 14:24:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:24:43 INFO - mozversion platform_version: 47.0 14:24:43 INFO - using testdate: 1463433883 14:24:43 INFO - actual date: 1463433883 14:24:43 INFO - starting webserver on 'localhost:59371' 14:24:43 INFO - SUITE-START | Running 2 tests 14:24:43 INFO - TEST-START | dromaeo_css 14:24:43 INFO - operating with platform_type : linux_ 14:24:43 INFO - Initialising browser for dromaeo_css test... 14:24:43 INFO - TEST-INFO | started process 32212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hOFrC/profile http://localhost:59371/getInfo.html) 14:24:48 INFO - PROCESS | 32212 | __metrics Screen width/height:1600/1200 14:24:48 INFO - PROCESS | 32212 | colorDepth:24 14:24:48 INFO - PROCESS | 32212 | Browser inner width/height: 1024/697 14:24:48 INFO - PROCESS | 32212 | __metrics 14:24:49 INFO - PROCESS | 32212 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:49 INFO - TEST-INFO | 32212: exit 0 14:24:49 INFO - Browser initialized. 14:24:49 INFO - Running cycle 1/1 for dromaeo_css test... 14:24:49 INFO - TEST-INFO | started process 32302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hOFrC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:01 INFO - PROCESS | 32302 | RSS: Main: 139112448 14:25:01 INFO - PROCESS | 32302 | 14:25:52 INFO - PROCESS | 32302 | 1463433952433 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] 14:28:00 INFO - PROCESS | 32302 | Cycle 1(1): loaded http://localhost:59371/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59371/tests/dromaeo/cssquery-ext.html) 14:28:01 INFO - PROCESS | 32302 | RSS: Main: 245895168 14:28:01 INFO - PROCESS | 32302 | 14:31:03 INFO - PROCESS | 32302 | Cycle 1(1): loaded http://localhost:59371/tests/dromaeo/cssquery-ext.html (next: http://localhost:59371/tests/dromaeo/cssquery-jquery.html) 14:31:03 INFO - PROCESS | 32302 | RSS: Main: 219389952 14:31:03 INFO - PROCESS | 32302 | 14:34:05 INFO - PROCESS | 32302 | Cycle 1(1): loaded http://localhost:59371/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59371/tests/dromaeo/cssquery-mootools.html) 14:34:06 INFO - PROCESS | 32302 | RSS: Main: 219160576 14:34:06 INFO - PROCESS | 32302 | 14:37:08 INFO - PROCESS | 32302 | Cycle 1(1): loaded http://localhost:59371/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59371/tests/dromaeo/cssquery-prototype.html) 14:37:08 INFO - PROCESS | 32302 | RSS: Main: 185929728 14:37:08 INFO - PROCESS | 32302 | 14:40:11 INFO - PROCESS | 32302 | Cycle 1(1): loaded http://localhost:59371/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59371/tests/dromaeo/cssquery-yui.html) 14:40:11 INFO - PROCESS | 32302 | RSS: Main: 202649600 14:40:11 INFO - PROCESS | 32302 | 14:43:13 INFO - PROCESS | 32302 | Cycle 1(1): loaded http://localhost:59371/tests/dromaeo/cssquery-yui.html (next: http://localhost:59371/tests/dromaeo/cssquery-dojo.html) 14:43:14 INFO - PROCESS | 32302 | RSS: Main: 250130432 14:43:14 INFO - PROCESS | 32302 | 14:43:14 INFO - PROCESS | 32302 | __start_tp_report 14:43:14 INFO - PROCESS | 32302 | _x_x_mozilla_page_load 14:43:14 INFO - PROCESS | 32302 | _x_x_mozilla_page_load_details 14:43:14 INFO - PROCESS | 32302 | |i|pagename|runs| 14:43:14 INFO - PROCESS | 32302 | |0;dojo.html;3296.175956010997;3332.150301673073;3350.5811773528294;3353.6143343515487;3378.898633041009;5363.517283444489;5420.485053919876;5447.836564903059;5465.890682186354;5482.424345443731;5424.267723857278;5448.182772584114;5463.754131064102;5470.863228419282;5471.917921231185;4944.233643785201;5009.949900500994;5069.9493005070035;5094.235864620299;5125.769340379673;4926.581240594536;4942.579880710144;4977.975110124463;5033.345665063555;5035.093683137034;5024.422191447976;5082.440931497551;5110.565601923841;5130.153524668425;5130.4356520782685;5023.196288593807;5085.98280343929;5096.643234973535;5100.311457953203;5102.846914592549;4848.587870031051;4868.78090485929;4949.653524253304;4951.678140920829;4989.725565093919;5299.814506492255;5304.230886521472;5308.734563271821;5313.44208858072;5341.626086173969;5904.321003084614;5907.970460147715;5909.143174239711;5909.143174239754;5909.793157239476;5746.770129194827;5876.6180198286975;5882.588218824684;5941.346451890288;5962.135490353874;5490.615656904019;5499.972500137514;5502.504774570268;5504.504594586467;5506.724663766796;5767.509761670305;5939.4951429129005;5996.8800623988145;5998.670073145931;6005.459508644243;5754.424557544212;5772.249607550992;5773.162891380726;5799.101139323411;5805.10020946754;5818.941810581925;5857.912131318034;5860.062390017577;5864.354920958691;5878.412158784087;5677.148427735872;5723.484886360247;5809.970950145223;5815.185873977646;5815.214945982323;5816.302043754692;5828.300603927556;5835.533157347402;5838.591298609142;5870.618409803435;4461.598456138963;4464.062546865194;4468.419105516262;4469.888252793641;4470.994026344047;4009.3985902114914;4012.117334186474;4038.6163314485666;4056.0873803394;4083.387491876183;5589.385167631557;5604.439556044363;5610.747516361774;5626.971865140648;5633.098704207389;5910.852228694231;5914.0241860093465;5917.55618328627;5918.8816223675285;5921.911171332434;5458.017556839807;5571.888562228733;5576.414476479992;5609.775608975595;5657.349404818417;5009.874753131201;5052.8484145475695;5074.5179207975925;5075.289459475676;5077.314562534085;6088.512918966472;6132.877342453126;6138.907916381258;6140.109684095871;6163.96918015407;5779.711014449261;5840.065589505659;5894.204282421818;5905.232319798399;5913.994620914369;6097.176881120992;6107.725152368243;6108.450239478469;6110.908336374869;6122.2959359674205;5787.681677507778;5797.623154495113;5797.826065218051;5799.681017544076;5801.8549536261935;5795.275590551181;5886.6173698709445;5915.645061296336;5923.259592550931;5953.3153687324775;5700.116481945305;5711.714414279352;5721.313442386774;5726.484616384545;5744.942550574441;5585.413531579288;5730.226419433323;5733.4266573344;5736.397678243891;5744.109663002241;5641.238432811518;5663.008973429715;5693.572982026448;5698.8290351289525;5722.6852523109965;5721.485066344049;5757.510611598061;5757.97121014409;5761;5764.193012978102;5539.058360078877;5555.166724991283;5621.2411324472305;5624.493795558419;5652.434756524314 14:43:14 INFO - PROCESS | 32302 | |1;ext.html;480.1117931826122;534.6177483099588;539.9055165346065;556.8914061757956;562.7158285066041;30347.544786828214;38336;38967.805160974225;39096.41355379664;39106.80446597763;42915.14169716612;43626.127477450515;43629.56370436295;43651.3452298215;43701.562984370146;8940.776480587989;9164.266858651325;9166.22087122592;9173.95413022934;9179.586918588646;8902.154295341932;8940.821183576325;9009.234215091692;9051.818963620724;9251;9134.36059475837;9217.585208665627;9245.352825302232;9317.906820931772;9318.534073296341;9250.213731832802;9325;9332.206762425201;9339.066093390675;9343;9034.54827258641;9152.54237288133;9220.40067395624;9238.214751746109;9243.90756092444;42070;42453;42506;42560.14879702389;42622.360664589745;3705.962940370589;3830.4254361845947;4403.867883963454;4426.380306757057;4492.034212644265;33120.668793312;33166.17084572905;33199.170020749676;33318.50022249668;33816.492752608734;4202.222588821078;4288.614024737789;4357.085012147453;4374.715643483163;4386.232409328387;277436;277445;278029.6098519515;279881;280133;62325;63305.68347158235;63322.683386583696;63343.6832815833;63714;67833.66083169651;82300.58849705714;83103;83334.58332708418;83577.58211209027;17691.292348305924;17790.644187116184;17875.37436189727;17932.462026139237;17999.2800287987;13198.73602527944;13334.133281336683;13369.064165508516;13375.93312033453;13386.732265354638;22824.543509129726;23159.7684023161;23314.184003559792;23348.182813601783;23405.297841064796;7790.9220907790195;7911.406644501571;8125.9187408126345;8131.308838748772;8226.629801658939;1019.4393083803878;1087.423665457309;1094.7536804218987;1106.7122548137543;1151.0388825330774;30309.848450757607;30407.23981900426;30531.236719081757;30839.074827754754;30998.070057898298;1071.2929466552039;1101.5215764529808;1160.6634076118;1177.1936223686803;1233.0690328801697;15764.448244311394;15816.92091539558;16093.275802588912;17016.65966680684;17108.572285692957;428333;434747;435797;435800;437725;61948;62458.37541624616;62638;62733.68633156896;62751.37248627455;1321.478016183602;1454.5854431486975;1499.212913220568;1531.7166324230054;1538.5845821628097;30208.891269416385;30215.244618884703;32809.67190328162;32891.83554082214;33499.33001340008;48000.27999580079;48133;48333.5166648329;48542.757286213346;48594.27108593303;208453;211704;212980;213264;213853;30984.690153099084;35143.297134057684;35419.64580354266;35599.64400355963;36149.27701446009;47892;48809.26786098282;49312.260316096006;49853;50012.24981625351;40474.797626011685;41073;41336.1732765349;41888.79055604825;42110.78944605257;38994.4150837732;39061.41407878941;39848.601513985646;40095.599044009185;40635.59364406318;38850.4172437408;39874.601253987086;39912;39958.2008359837;39969;34982.901025937506;35682.64317356897;35838.283234335686;36364.27271454609;36907;27557.31106722348;27919.44161116807;27977.72022279751;28034.579481308203;28120.156395308175 14:43:14 INFO - PROCESS | 32302 | |2;jquery.html;355.4384073164401;373.8915714442811;374.51313292719476;386.65780784006165;390.48066072124044;17082.31670733169;18174.90912545437;19071.809281907175;19587.412377628694;19592.70610940837;17413.216405261763;17687.46937591871;18286;18321.08394580269;18326.175322110503;5644.6613203207735;5780.53755699543;5805.854853628651;5813.2152159458565;5819.883602327972;4182.602652747984;5757.712114394284;6125.663088530129;6306.432421082101;6342.873142537146;6259.37406259375;6275.717592708339;6300;6307.463865571432;6309.495240380781;6144.907826382608;6187.876242475148;6327.746890124389;6339.746410143589;6340.112384266206;3858.6527212551005;5456.91814622781;5590.301212348457;5657.179708942181;5664;21349.57300853974;21692.783072169233;21898.343049708375;22328.441788955242;22329.888350558307;2367.893444794988;2432.5621388150125;2433.3065076453126;2468.123816045314;2528.671272734551;13691;13920.30398480072;14083.577492675236;14241.359138838778;14403.135811851322;1864.1797609051973;1923.9038048097539;1935.1872213670292;1951.219512195119;1977.6440240756658;65415.67292163556;66089;66177.66911165461;66735.66632166857;67214.9917751239;10209.846852297222;10511;10582.470876456146;10774.084202842847;11083.612073577386;14799.482018129314;14894.776578351333;15036.323365448581;15038.097714137186;15043.398264069314;8163.918360816316;8309.086000539935;8360.372972027122;8365.498070115691;8397.496150231005;8132.837343253102;8166.550839703873;8207.138250483733;8217.58912054395;8284.171582841667;6235.937640623626;6273.12176295319;6314.431701146918;6333.461655759312;6375.10748495211;1787.7675902132898;1811.9003454810113;1882.6799444094536;1883.6986082226779;1913.7703475582741;945.4091193004373;970.5923512124924;972.7957129002847;1096.446294621211;1140.5950887435008;17358.305667773147;17702.468925932244;17779.377721779936;17873.37443189508;18520.073996300132;1036.6527213383602;1066.1524088349781;1073.7369344510646;1102.327580176092;1123.2811000959393;10271.435071071162;10712.73218169552;10758.139348852073;10762.461876906124;10886.782264354668;478760;488356;493186;499505;500163;67352.66323668449;69416;69583.95624065644;69641.65179174174;70787;1066.0991462214417;1069.9144068474504;1084.35480888871;1091.028984204059;1104.364990130662;16242.593935151242;16252.837471625606;16391.098489583186;16393.754093688367;16436.917815410845;33503.66496335006;33635.49546756849;35088.47367289442;35222.47166292559;35522.467162992056;44591.33113003243;46131;46559;46813;47278.34525791581;8610;8833.07252738479;8893.688720894737;8897.73306800797;9052.728418147466;13167.473301068234;13371;13663.385147668578;13724.725505490034;13797.310134493035;11302.095832333229;11534.250273732181;11550.711232219262;11655.30068195911;11895.82156267674;11676.182667213214;11835;11850.76298474043;11895.940520297343;11950.641480755592;11672.474738636613;11679.182457227913;11761.353125578175;11971.281723096643;12268.754624907631;8686;8739.082396348545;8876.556172191236;8885;8997;11037.558497660004;11136.164787640797;11234.101271898066;11523.884761152281;11604.129690273094 14:43:14 INFO - PROCESS | 32302 | |3;mootools.html;1480.1341215388998;1572.3474757975437;1579.8973066750661;1820.2173065581803;1973.6348775476529;7972.561509116997;8149.388795840314;8154.225348591889;8160.551169685665;8167.305779008784;8219.260266576008;8391.24478796908;8394.958025209866;8398.370122240825;8403.327733781298;2434.573949558829;2472.5796614575474;2475.096589744739;2475.356407334088;2476.9752302477013;2435.8051355891484;2514.270861450186;2515.811314151437;2531.0508559290265;2536.759007894247;2465.2604218734396;2469.8888550015295;2494.625806129077;2496.500699860026;2497.5504409206337;2478.6405971134177;2488.5645012122895;2491.426971796479;2498.5502609530276;2511.598144296913;2482.491089326684;2512.032867346085;2528.5448619248527;2529.72173060965;2569.897204111833;8280.461769984931;8327.625256863455;8330.291925186366;8331;8336.749897503025;5178.171492561172;5367.221752845816;5371.4897084776885;5372;5374.113271310229;3302.983485082559;3334.61651910031;3352.8155951422664;3373.628900820908;3390.8135052572097;1032.045358043814;1069.101954358335;1071.1537885070784;1076.7954088723118;1086.5490821309147;11085.889141108566;11323.716907077389;11379.089672826154;11385;11386.202965792398;4802.975985120052;4822.300766388854;4839.563909624136;4872.930054065916;4906.509349065136;10363.119134873621;10364.119049880694;10371.377717336984;10382.221333400024;10391.948040259751;5494.478024587658;5497.422770609029;5499.945000550023;5500.834974950758;5503.724813759296;4286.164197981426;4796.976015119972;4874.46380898101;4889.119958407449;4898.975505122452;3914.941275880864;4009.7393669411395;4030.496187976503;4038.8990275243355;4051.372037334218;1354.1604205392719;1365.9317034148253;1368.8904887608967;1375.277979061001;1375.6767159717458;1452.0996981871308;1457.3951809998732;1465.413834466222;1469.2433396800657;1499.2054211268046;7953.2842044216295;8103.83792324162;8109.107998120202;8153.7553873383895;8153.8776918346275;1151.5796734192127;1170.163333216737;1217.4095563651622;1224.8591411987557;1258.3016425883538;6289.119523266746;6324.209473815773;6343.9682801585695;6379.904301435482;6380.489560835122;9845.212383009342;10294.588216471408;10333.173346132291;10337.121344685636;10338.844917326247;9735.610575576897;9959.900400996043;10056.094951454405;10128.088472037552;10267.9486602568;7855.921440785633;7971.123176450586;8019.679212831538;8066.23370779775;8076.8384632307025;7675.61621918913;7677.961610191914;7730.7680769577;7751.806204844924;7762.262585054411;8626.000618065415;8668.176523230282;8718.694845680371;8847.336449766422;8910;8837.762713220025;8968.506732129534;8975.955120224357;9184.724458266262;9286.674966376144;6520.119783829123;6923.9307606923285;7107.395871350993;7248.746293879689;7364.3003914628025;8014.519128852287;8028.718994835152;8046.0344758629335;8064.55644939534;8074.959625202071;7241.963790181016;7442;7475;7566.470347075652;7590.544567325978;7241.660292845841;7290.088738907637;7419.925800741924;7454.217307182667;7556.584387858501;7438.814029649302;7486;7504.3246107850555;7509.1739908608915;7509.586972716553;6622.701978410887;6883.174019117738;6950.756723514653;6958.582485050913;6966.825829354104;6813.625250611264;6878.484113691393;6910.550814197061;6920.377166055079;6922.7923162305215 14:43:14 INFO - PROCESS | 32302 | |4;prototype.html;352.6191712950014;354.4417542370767;355.0201444014519;357.64771699875615;363.52559909318336;5896.439838215368;5905.468507834294;5917.786853694987;5938.762449502025;5953.3748956359495;5802.506786923117;5872.354041055481;5882.029465138247;5882.14708867214;5885.058390657496;4343.804528796196;4488.663350248728;4616.722996620197;4623.121606894696;4638.095571363586;4595.701279416827;4614.884627884297;4622.422197225347;4630.0276941842085;4636.211843986531;4564.97717511412;4587.174308624446;4603.723776573416;4605.4933957264675;4615.053913947632;4375.365571992059;4508.188526065307;4602.286645569942;4613.746243956581;4633.1660301145785;4088.9386659200136;4097.7541347518945;4100.077482566398;4102.958970410287;4108.753474791522;5659.037963546207;5659.4340565943485;5660.943390566124;5664.433556644344;5686.5735069869515;5341.919871201935;5342.866428339284;5345.893082138336;5352.545033672142;5364.758585863646;6199.411055949723;6209.9068513972325;6210.50315974721;6212.782552610637;6215.440610345046;4424.889377765549;4511.233090374644;4511.977440112779;4513.842015529441;4514.503404625489;6456.418922296969;6469.417752402259;6477.902831457532;6489.383508566679;6493.188351456068;4601.930971035437;4608.331791890158;4610.077984403066;4610.2854057621125;4615.746133962597;4692.7653617319;4700.989287303178;4702.177119004161;4702.435707715028;4717.150912835723;5324.307839980777;5326.0945639240645;5335.62650614461;5342.652727572696;5343.7060961647485;6130.386961303923;6273.560850740496;6285.402886725754;6285.402886725754;6289.685515724287;1633.7059329320598;1656.445090894564;1659.991700041492;1662.6342204715186;1671.9247633856262;1073.5974009746344;1120.6581992492206;1132.6885106595753;1142.959996400122;1155.0932517973351;6050.878982420327;6051.636901785819;6066.726997285133;6066.848328791727;6074.848128796727;6377.1390862233;6388.201474815648;6392.360763923663;6397.808065758035;6401.775937842153;6032.758689652364;6036.577439579188;6037.456628903332;6045.911735887495;6050.515958723292;3416.5046068319953;3445.6898879101;3452.58568971725;3457.5505184325875;3457.792532448061;6425.164728585348;6629.502787290876;6641.302663220389;6644.933550664431;6656.134702488743;6507.577007494498;6512.283648798629;6517.4134327910715;6524.771632992917;6545.967270163619;6637.369449902251;6640.037194606755;6640.136782218377;6658.966705166443;6662.333766623396;6366.586171898812;6367.61794292344;6369.649669268049;6379.106925030592;6388.329225431263;6235.220597425322;6287.71705273273;6291.182146321132;6297.2128483939505;6464.773732919325;6735.057092007025;6739.898901516579;6762.289959554176;6769.763058292936;6918.515703900679;4541.069080838486;4602.263637818067;4603.148417542765;4605.700629459075;4610.677252592421;6527.15147030883;6531.11829902957;6537.771178008747;6538.803835884931;6540.084388185753;6341.841453963688;6342.23893132827;6344.365563443619;6353.14232578596;6354.046892966092;6103.542234332354;6349.936500634934;6356.459700925473;6366.840828979312;6369.522285828674;6180.412860778219;6197.4732147767945;6210.31686514474;6210.689465526615;6214.8135555933395;6377.266614339411;6378.075179099097;6379.776707815204;6392.20097487814;6401.743930242738;5909.113632955091;6034.21555197839;6038.969805150946;6214.844628884314;6226.377362263918 14:43:14 INFO - PROCESS | 32302 | |5;yui.html;778.4823092643393;805.532790981231;871.5555066915879;894.2801045158647;914.4513292024784;15162.469313574027;15318.387264509407;15350.46273380432;15379.154146521936;15416.537503874888;12465.875341246585;14086.210143419263;14218.075825071362;14278.143311401323;14306.642333941656;906.714384968736;921.1019256225194;921.5714692667908;923.949182794946;924.6347692661394;907.8275127725711;908.8454962656331;912.9360944733871;913.3469569257979;913.5295322908707;944.593824655398;951.8952915179359;952.1716106986931;954.3605784124618;962.0523784072683;942.0626476655772;942.7030485397078;943.7499062748377;944.2681921510815;956.6986399284237;700.250731717063;702.4450683959717;704.851981083973;709.8402859356655;716.7240612364225;13706.657333566642;13706.725865482735;13770.449182032708;13771.449142034307;13783.379747911367;12221.266723996589;12240.081993850408;12332.075094367869;12446.502139914393;12457.065720070941;10660.786784264348;10693.144548436107;10724.463776811128;10928.125749939985;11158.66524004273;3789.829457674384;3867.941980870289;3870.767753934773;3877.3602355611292;3877.86427475037;45602.771986140186;49599.75200124012;51299.48700512984;53324.73337633326;53457;11311.208215424842;11375.089992800557;11463.484143213574;11478.59824906141;11573.074154067654;17270.395536156175;19273.807261927202;19514;19524.316648917218;19866.304679336445;8496.320294376435;8591.398602097917;8618.138186181457;8688.869666955;8972.775680607907;4836.564709176191;4900.681455705368;4918.5573298403315;4938.777755001033;4985.626078044161;3367.410703126943;3381.1547113221695;3386.7629265951145;3388.8305584720665;3393.5588373511778;643.411278680012;646.7348387161242;647.2427260105687;648.4002297874541;650.5381179362611;595.9076343166817;625.7152995387088;630.9463695585927;674.8076798112514;722.5086940880252;7855.685772569148;8166.781186827175;8188.754337369888;8351.707690230935;8440.366972477088;718.6730037832878;738.2027410396759;744.8919906613619;752.3905636434506;759.8556274307974;3958.929707379128;4015.0363912661337;4036.495438070241;4053.9594604054173;4114.897127571775;55671.72164139153;56272;56803.43196568064;59156.704216479506;60324.39675603276;46915;46968.295475567895;47380;49611.751941240065;50079.744816586805;45060.32409513794;45198.32202516965;45614.77192614082;45689.771551142694;45887;8924.509151996703;9074.637014519609;9188.40275382098;9339.066093390607;9375.578098985425;30877.69122308748;31311.21721956969;33522.32955340928;35944;36613;43500.78249608732;43896.34155487734;44425.55574444214;44486.555134448245;44586.55413445824;12182.329971851634;12324.383780811102;12377.62867113988;12568.371581421075;12612.49550017989;13293.401796918968;13355.3990070449;13645.181289122684;13758.518451854137;14185.574432767033;12251.264924104582;12428.689282767642;12543.184692994926;13039.217646941213;13046;12214.14500984958;12727.299998500172;12732.745345093232;13143.802842957171;13432.798508022192;11998.880011199777;12226;12292.81560776607;12630.810537842124;12807.423665934868;10286.177105831664;10293.794124117625;10493.213009024506;10746.570137194425;10851.294665846695;10457;10700.785984280115;10789.40658263803;10799.514021868878;10855.077318428022 14:43:14 INFO - PROCESS | 32302 | __end_tp_report 14:43:14 INFO - PROCESS | 32302 | __start_cc_report 14:43:14 INFO - PROCESS | 32302 | _x_x_mozilla_cycle_collect,800 14:43:14 INFO - PROCESS | 32302 | __end_cc_report 14:43:14 INFO - PROCESS | 32302 | __startTimestamp1463434994198__endTimestamp 14:43:14 INFO - PROCESS | 32302 | 14:43:14 INFO - PROCESS | 32302 | ------- Summary: start ------- 14:43:14 INFO - PROCESS | 32302 | Number of tests: 6 14:43:14 INFO - PROCESS | 32302 | 14:43:14 INFO - PROCESS | 32302 | [#0] dojo.html Cycles:165 Average:5457.13 Median:5663.01 stddev:596.36 (10.5%) stddev-sans-first:573.59 14:43:14 INFO - PROCESS | 32302 | Values: 3296.2 3332.2 3350.6 3353.6 3378.9 5363.5 5420.5 5447.8 5465.9 5482.4 5424.3 5448.2 5463.8 5470.9 5471.9 4944.2 5009.9 5069.9 5094.2 5125.8 4926.6 4942.6 4978.0 5033.3 5035.1 5024.4 5082.4 5110.6 5130.2 5130.4 5023.2 5086.0 5096.6 5100.3 5102.8 4848.6 4868.8 4949.7 4951.7 4989.7 5299.8 5304.2 5308.7 5313.4 5341.6 5904.3 5908.0 5909.1 5909.1 5909.8 5746.8 5876.6 5882.6 5941.3 5962.1 5490.6 5500.0 5502.5 5504.5 5506.7 5767.5 5939.5 5996.9 5998.7 6005.5 5754.4 5772.2 5773.2 5799.1 5805.1 5818.9 5857.9 5860.1 5864.4 5878.4 5677.1 5723.5 5810.0 5815.2 5815.2 5816.3 5828.3 5835.5 5838.6 5870.6 4461.6 4464.1 4468.4 4469.9 4471.0 4009.4 4012.1 4038.6 4056.1 4083.4 5589.4 5604.4 5610.7 5627.0 5633.1 5910.9 5914.0 5917.6 5918.9 5921.9 5458.0 5571.9 5576.4 5609.8 5657.3 5009.9 5052.8 5074.5 5075.3 5077.3 6088.5 6132.9 6138.9 6140.1 6164.0 5779.7 5840.1 5894.2 5905.2 5914.0 6097.2 6107.7 6108.5 6110.9 6122.3 5787.7 5797.6 5797.8 5799.7 5801.9 5795.3 5886.6 5915.6 5923.3 5953.3 5700.1 5711.7 5721.3 5726.5 5744.9 5585.4 5730.2 5733.4 5736.4 5744.1 5641.2 5663.0 5693.6 5698.8 5722.7 5721.5 5757.5 5758.0 5761.0 5764.2 5539.1 5555.2 5621.2 5624.5 5652.4 14:43:14 INFO - PROCESS | 32302 | 14:43:14 INFO - PROCESS | 32302 | [#1] ext.html Cycles:180 Average:50114.52 Median:40285.20 stddev:84922.28 (210.8%) stddev-sans-first:85078.73 14:43:14 INFO - PROCESS | 32302 | Values: 480.1 534.6 539.9 556.9 562.7 30347.5 38336.0 38967.8 39096.4 39106.8 42915.1 43626.1 43629.6 43651.3 43701.6 8940.8 9164.3 9166.2 9174.0 9179.6 8902.2 8940.8 9009.2 9051.8 9251.0 9134.4 9217.6 9245.4 9317.9 9318.5 9250.2 9325.0 9332.2 9339.1 9343.0 9034.5 9152.5 9220.4 9238.2 9243.9 42070.0 42453.0 42506.0 42560.1 42622.4 3706.0 3830.4 4403.9 4426.4 4492.0 33120.7 33166.2 33199.2 33318.5 33816.5 4202.2 4288.6 4357.1 4374.7 4386.2 277436.0 277445.0 278029.6 279881.0 280133.0 62325.0 63305.7 63322.7 63343.7 63714.0 67833.7 82300.6 83103.0 83334.6 83577.6 17691.3 17790.6 17875.4 17932.5 17999.3 13198.7 13334.1 13369.1 13375.9 13386.7 22824.5 23159.8 23314.2 23348.2 23405.3 7790.9 7911.4 8125.9 8131.3 8226.6 1019.4 1087.4 1094.8 1106.7 1151.0 30309.8 30407.2 30531.2 30839.1 30998.1 1071.3 1101.5 1160.7 1177.2 1233.1 15764.4 15816.9 16093.3 17016.7 17108.6 428333.0 434747.0 435797.0 435800.0 437725.0 61948.0 62458.4 62638.0 62733.7 62751.4 1321.5 1454.6 1499.2 1531.7 1538.6 30208.9 30215.2 32809.7 32891.8 33499.3 48000.3 48133.0 48333.5 48542.8 48594.3 208453.0 211704.0 212980.0 213264.0 213853.0 30984.7 35143.3 35419.6 35599.6 36149.3 47892.0 48809.3 49312.3 49853.0 50012.2 40474.8 41073.0 41336.2 41888.8 42110.8 38994.4 39061.4 39848.6 40095.6 40635.6 38850.4 39874.6 39912.0 39958.2 39969.0 34982.9 35682.6 35838.3 36364.3 36907.0 27557.3 27919.4 27977.7 28034.6 28120.2 14:43:14 INFO - PROCESS | 32302 | 14:43:14 INFO - PROCESS | 32302 | [#2] jquery.html Cycles:180 Average:27541.55 Median:22329.17 stddev:80328.40 (359.7%) stddev-sans-first:80527.81 14:43:14 INFO - PROCESS | 32302 | Values: 355.4 373.9 374.5 386.7 390.5 17082.3 18174.9 19071.8 19587.4 19592.7 17413.2 17687.5 18286.0 18321.1 18326.2 5644.7 5780.5 5805.9 5813.2 5819.9 4182.6 5757.7 6125.7 6306.4 6342.9 6259.4 6275.7 6300.0 6307.5 6309.5 6144.9 6187.9 6327.7 6339.7 6340.1 3858.7 5456.9 5590.3 5657.2 5664.0 21349.6 21692.8 21898.3 22328.4 22329.9 2367.9 2432.6 2433.3 2468.1 2528.7 13691.0 13920.3 14083.6 14241.4 14403.1 1864.2 1923.9 1935.2 1951.2 1977.6 65415.7 66089.0 66177.7 66735.7 67215.0 10209.8 10511.0 10582.5 10774.1 11083.6 14799.5 14894.8 15036.3 15038.1 15043.4 8163.9 8309.1 8360.4 8365.5 8397.5 8132.8 8166.6 8207.1 8217.6 8284.2 6235.9 6273.1 6314.4 6333.5 6375.1 1787.8 1811.9 1882.7 1883.7 1913.8 945.4 970.6 972.8 1096.4 1140.6 17358.3 17702.5 17779.4 17873.4 18520.1 1036.7 1066.2 1073.7 1102.3 1123.3 10271.4 10712.7 10758.1 10762.5 10886.8 478760.0 488356.0 493186.0 499505.0 500163.0 67352.7 69416.0 69584.0 69641.7 70787.0 1066.1 1069.9 1084.4 1091.0 1104.4 16242.6 16252.8 16391.1 16393.8 16436.9 33503.7 33635.5 35088.5 35222.5 35522.5 44591.3 46131.0 46559.0 46813.0 47278.3 8610.0 8833.1 8893.7 8897.7 9052.7 13167.5 13371.0 13663.4 13724.7 13797.3 11302.1 11534.3 11550.7 11655.3 11895.8 11676.2 11835.0 11850.8 11895.9 11950.6 11672.5 11679.2 11761.4 11971.3 12268.8 8686.0 8739.1 8876.6 8885.0 8997.0 11037.6 11136.2 11234.1 11523.9 11604.1 14:43:14 INFO - PROCESS | 32302 | 14:43:14 INFO - PROCESS | 32302 | [#3] mootools.html Cycles:180 Average:5915.55 Median:5373.06 stddev:3001.15 (55.9%) stddev-sans-first:2991.05 14:43:14 INFO - PROCESS | 32302 | Values: 1480.1 1572.3 1579.9 1820.2 1973.6 7972.6 8149.4 8154.2 8160.6 8167.3 8219.3 8391.2 8395.0 8398.4 8403.3 2434.6 2472.6 2475.1 2475.4 2477.0 2435.8 2514.3 2515.8 2531.1 2536.8 2465.3 2469.9 2494.6 2496.5 2497.6 2478.6 2488.6 2491.4 2498.6 2511.6 2482.5 2512.0 2528.5 2529.7 2569.9 8280.5 8327.6 8330.3 8331.0 8336.7 5178.2 5367.2 5371.5 5372.0 5374.1 3303.0 3334.6 3352.8 3373.6 3390.8 1032.0 1069.1 1071.2 1076.8 1086.5 11085.9 11323.7 11379.1 11385.0 11386.2 4803.0 4822.3 4839.6 4872.9 4906.5 10363.1 10364.1 10371.4 10382.2 10391.9 5494.5 5497.4 5499.9 5500.8 5503.7 4286.2 4797.0 4874.5 4889.1 4899.0 3914.9 4009.7 4030.5 4038.9 4051.4 1354.2 1365.9 1368.9 1375.3 1375.7 1452.1 1457.4 1465.4 1469.2 1499.2 7953.3 8103.8 8109.1 8153.8 8153.9 1151.6 1170.2 1217.4 1224.9 1258.3 6289.1 6324.2 6344.0 6379.9 6380.5 9845.2 10294.6 10333.2 10337.1 10338.8 9735.6 9959.9 10056.1 10128.1 10267.9 7855.9 7971.1 8019.7 8066.2 8076.8 7675.6 7678.0 7730.8 7751.8 7762.3 8626.0 8668.2 8718.7 8847.3 8910.0 8837.8 8968.5 8976.0 9184.7 9286.7 6520.1 6923.9 7107.4 7248.7 7364.3 8014.5 8028.7 8046.0 8064.6 8075.0 7242.0 7442.0 7475.0 7566.5 7590.5 7241.7 7290.1 7419.9 7454.2 7556.6 7438.8 7486.0 7504.3 7509.2 7509.6 6622.7 6883.2 6950.8 6958.6 6966.8 6813.6 6878.5 6910.6 6920.4 6922.8 14:43:14 INFO - PROCESS | 32302 | 14:43:14 INFO - PROCESS | 32302 | [#4] prototype.html Cycles:180 Average:5279.66 Median:5993.07 stddev:1550.67 (25.9%) stddev-sans-first:1510.28 14:43:14 INFO - PROCESS | 32302 | Values: 352.6 354.4 355.0 357.6 363.5 5896.4 5905.5 5917.8 5938.8 5953.4 5802.5 5872.4 5882.0 5882.1 5885.1 4343.8 4488.7 4616.7 4623.1 4638.1 4595.7 4614.9 4622.4 4630.0 4636.2 4565.0 4587.2 4603.7 4605.5 4615.1 4375.4 4508.2 4602.3 4613.7 4633.2 4088.9 4097.8 4100.1 4103.0 4108.8 5659.0 5659.4 5660.9 5664.4 5686.6 5341.9 5342.9 5345.9 5352.5 5364.8 6199.4 6209.9 6210.5 6212.8 6215.4 4424.9 4511.2 4512.0 4513.8 4514.5 6456.4 6469.4 6477.9 6489.4 6493.2 4601.9 4608.3 4610.1 4610.3 4615.7 4692.8 4701.0 4702.2 4702.4 4717.2 5324.3 5326.1 5335.6 5342.7 5343.7 6130.4 6273.6 6285.4 6285.4 6289.7 1633.7 1656.4 1660.0 1662.6 1671.9 1073.6 1120.7 1132.7 1143.0 1155.1 6050.9 6051.6 6066.7 6066.8 6074.8 6377.1 6388.2 6392.4 6397.8 6401.8 6032.8 6036.6 6037.5 6045.9 6050.5 3416.5 3445.7 3452.6 3457.6 3457.8 6425.2 6629.5 6641.3 6644.9 6656.1 6507.6 6512.3 6517.4 6524.8 6546.0 6637.4 6640.0 6640.1 6659.0 6662.3 6366.6 6367.6 6369.6 6379.1 6388.3 6235.2 6287.7 6291.2 6297.2 6464.8 6735.1 6739.9 6762.3 6769.8 6918.5 4541.1 4602.3 4603.1 4605.7 4610.7 6527.2 6531.1 6537.8 6538.8 6540.1 6341.8 6342.2 6344.4 6353.1 6354.0 6103.5 6349.9 6356.5 6366.8 6369.5 6180.4 6197.5 6210.3 6210.7 6214.8 6377.3 6378.1 6379.8 6392.2 6401.7 5909.1 6034.2 6039.0 6214.8 6226.4 14:43:14 INFO - PROCESS | 32302 | 14:43:14 INFO - PROCESS | 32302 | [#5] yui.html Cycles:180 Average:14201.59 Median:43698.56 stddev:15724.46 (36.0%) stddev-sans-first:15736.26 14:43:14 INFO - PROCESS | 32302 | Values: 778.5 805.5 871.6 894.3 914.5 15162.5 15318.4 15350.5 15379.2 15416.5 12465.9 14086.2 14218.1 14278.1 14306.6 906.7 921.1 921.6 923.9 924.6 907.8 908.8 912.9 913.3 913.5 944.6 951.9 952.2 954.4 962.1 942.1 942.7 943.7 944.3 956.7 700.3 702.4 704.9 709.8 716.7 13706.7 13706.7 13770.4 13771.4 13783.4 12221.3 12240.1 12332.1 12446.5 12457.1 10660.8 10693.1 10724.5 10928.1 11158.7 3789.8 3867.9 3870.8 3877.4 3877.9 45602.8 49599.8 51299.5 53324.7 53457.0 11311.2 11375.1 11463.5 11478.6 11573.1 17270.4 19273.8 19514.0 19524.3 19866.3 8496.3 8591.4 8618.1 8688.9 8972.8 4836.6 4900.7 4918.6 4938.8 4985.6 3367.4 3381.2 3386.8 3388.8 3393.6 643.4 646.7 647.2 648.4 650.5 595.9 625.7 630.9 674.8 722.5 7855.7 8166.8 8188.8 8351.7 8440.4 718.7 738.2 744.9 752.4 759.9 3958.9 4015.0 4036.5 4054.0 4114.9 55671.7 56272.0 56803.4 59156.7 60324.4 46915.0 46968.3 47380.0 49611.8 50079.7 45060.3 45198.3 45614.8 45689.8 45887.0 8924.5 9074.6 9188.4 9339.1 9375.6 30877.7 31311.2 33522.3 35944.0 36613.0 43500.8 43896.3 44425.6 44486.6 44586.6 12182.3 12324.4 12377.6 12568.4 12612.5 13293.4 13355.4 13645.2 13758.5 14185.6 12251.3 12428.7 12543.2 13039.2 13046.0 12214.1 12727.3 12732.7 13143.8 13432.8 11998.9 12226.0 12292.8 12630.8 12807.4 10286.2 10293.8 10493.2 10746.6 10851.3 10457.0 10700.8 10789.4 10799.5 10855.1 14:43:14 INFO - PROCESS | 32302 | -------- Summary: end -------- 14:43:14 INFO - PROCESS | 32302 | 14:43:14 INFO - TEST-INFO | 32302: exit 0 14:43:14 INFO - TEST-OK | dromaeo_css | took 1110957ms 14:43:14 INFO - TEST-START | kraken 14:43:14 INFO - operating with platform_type : linux_ 14:43:14 INFO - Initialising browser for kraken test... 14:43:14 INFO - TEST-INFO | started process 32494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp15ka5N/profile http://localhost:59371/getInfo.html) 14:43:18 INFO - PROCESS | 32494 | __metrics Screen width/height:1600/1200 14:43:18 INFO - PROCESS | 32494 | colorDepth:24 14:43:18 INFO - PROCESS | 32494 | Browser inner width/height: 1024/697 14:43:18 INFO - PROCESS | 32494 | __metrics 14:43:20 INFO - PROCESS | 32494 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:43:20 INFO - TEST-INFO | 32494: exit 0 14:43:20 INFO - Browser initialized. 14:43:20 INFO - Running cycle 1/1 for kraken test... 14:43:21 INFO - TEST-INFO | started process 32586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp15ka5N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:43:32 INFO - PROCESS | 32586 | RSS: Main: 139542528 14:43:32 INFO - PROCESS | 32586 | 14:43:35 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59371/tests/kraken/driver.html?testName=audio-beat-detection) 14:43:35 INFO - PROCESS | 32586 | RSS: Main: 174247936 14:43:35 INFO - PROCESS | 32586 | 14:43:38 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59371/tests/kraken/driver.html?testName=audio-dft) 14:43:39 INFO - PROCESS | 32586 | RSS: Main: 171847680 14:43:39 INFO - PROCESS | 32586 | 14:43:41 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59371/tests/kraken/driver.html?testName=audio-fft) 14:43:42 INFO - PROCESS | 32586 | RSS: Main: 169574400 14:43:42 INFO - PROCESS | 32586 | 14:43:44 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59371/tests/kraken/driver.html?testName=audio-oscillator) 14:43:45 INFO - PROCESS | 32586 | RSS: Main: 171192320 14:43:45 INFO - PROCESS | 32586 | 14:43:47 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59371/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:43:47 INFO - PROCESS | 32586 | RSS: Main: 168841216 14:43:47 INFO - PROCESS | 32586 | 14:43:50 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59371/tests/kraken/driver.html?testName=imaging-darkroom) 14:43:51 INFO - PROCESS | 32586 | RSS: Main: 168382464 14:43:51 INFO - PROCESS | 32586 | 14:43:54 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59371/tests/kraken/driver.html?testName=imaging-desaturate) 14:43:55 INFO - PROCESS | 32586 | RSS: Main: 168333312 14:43:55 INFO - PROCESS | 32586 | 14:43:58 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59371/tests/kraken/driver.html?testName=json-parse-financial) 14:43:58 INFO - PROCESS | 32586 | RSS: Main: 168157184 14:43:58 INFO - PROCESS | 32586 | 14:44:00 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59371/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:00 INFO - PROCESS | 32586 | RSS: Main: 174706688 14:44:00 INFO - PROCESS | 32586 | 14:44:02 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59371/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:03 INFO - PROCESS | 32586 | RSS: Main: 171839488 14:44:03 INFO - PROCESS | 32586 | 14:44:05 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59371/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:05 INFO - PROCESS | 32586 | RSS: Main: 178556928 14:44:05 INFO - PROCESS | 32586 | 14:44:08 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:08 INFO - PROCESS | 32586 | RSS: Main: 183140352 14:44:08 INFO - PROCESS | 32586 | 14:44:11 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:11 INFO - PROCESS | 32586 | RSS: Main: 181645312 14:44:11 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | Cycle 1(1): loaded http://localhost:59371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59371/tests/kraken/driver.html?testName=ai-astar) 14:44:13 INFO - PROCESS | 32586 | RSS: Main: 244367360 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | __start_tp_report 14:44:13 INFO - PROCESS | 32586 | _x_x_mozilla_page_load 14:44:13 INFO - PROCESS | 32586 | _x_x_mozilla_page_load_details 14:44:13 INFO - PROCESS | 32586 | |i|pagename|runs| 14:44:13 INFO - PROCESS | 32586 | |0;ai-astar;110;112;106;112;110;110;99;110;109;110 14:44:13 INFO - PROCESS | 32586 | |1;audio-beat-detection;161;128;159;168;128;156;150;128;171;133 14:44:13 INFO - PROCESS | 32586 | |2;audio-dft;161;160;161;160;162;161;160;164;160;161 14:44:13 INFO - PROCESS | 32586 | |3;audio-fft;76;76;75;164;76;77;74;75;161;75 14:44:13 INFO - PROCESS | 32586 | |4;audio-oscillator;94;94;135;94;93;93;140;93;93;149 14:44:13 INFO - PROCESS | 32586 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;118;116;117 14:44:13 INFO - PROCESS | 32586 | |6;imaging-darkroom;146;146;146;145;145;146;145;145;145;146 14:44:13 INFO - PROCESS | 32586 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;96 14:44:13 INFO - PROCESS | 32586 | |8;json-parse-financial;59;55;58;55;56;55;57;59;53;54 14:44:13 INFO - PROCESS | 32586 | |9;json-stringify-tinderbox;65;66;66;68;67;67;67;66;66;67 14:44:13 INFO - PROCESS | 32586 | |10;stanford-crypto-aes;78;80;80;79;78;78;79;77;78;78 14:44:13 INFO - PROCESS | 32586 | |11;stanford-crypto-ccm;114;113;111;122;113;113;114;117;110;111 14:44:13 INFO - PROCESS | 32586 | |12;stanford-crypto-pbkdf2;146;136;142;143;144;136;146;145;144;134 14:44:13 INFO - PROCESS | 32586 | |13;stanford-crypto-sha256-iterative;68;70;68;66;65;66;67;68;66;64 14:44:13 INFO - PROCESS | 32586 | __end_tp_report 14:44:13 INFO - PROCESS | 32586 | __start_cc_report 14:44:13 INFO - PROCESS | 32586 | _x_x_mozilla_cycle_collect,1024 14:44:13 INFO - PROCESS | 32586 | __end_cc_report 14:44:13 INFO - PROCESS | 32586 | __startTimestamp1463435053628__endTimestamp 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | ------- Summary: start ------- 14:44:13 INFO - PROCESS | 32586 | Number of tests: 14 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.82 (3.5%) stddev-sans-first:4.03 14:44:13 INFO - PROCESS | 32586 | Values: 110.0 112.0 106.0 112.0 110.0 110.0 99.0 110.0 109.0 110.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:157.50 stddev:17.36 (11.0%) stddev-sans-first:17.78 14:44:13 INFO - PROCESS | 32586 | Values: 161.0 128.0 159.0 168.0 128.0 156.0 150.0 128.0 171.0 133.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 14:44:13 INFO - PROCESS | 32586 | Values: 161.0 160.0 161.0 160.0 162.0 161.0 160.0 164.0 160.0 161.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:36.70 (48.6%) stddev-sans-first:38.41 14:44:13 INFO - PROCESS | 32586 | Values: 76.0 76.0 75.0 164.0 76.0 77.0 74.0 75.0 161.0 75.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.00 stddev:23.38 (25.1%) stddev-sans-first:24.26 14:44:13 INFO - PROCESS | 32586 | Values: 94.0 94.0 135.0 94.0 93.0 93.0 140.0 93.0 93.0 149.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 14:44:13 INFO - PROCESS | 32586 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 118.0 116.0 117.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:44:13 INFO - PROCESS | 32586 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:44:13 INFO - PROCESS | 32586 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:2.08 (3.7%) stddev-sans-first:1.92 14:44:13 INFO - PROCESS | 32586 | Values: 59.0 55.0 58.0 55.0 56.0 55.0 57.0 59.0 53.0 54.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 14:44:13 INFO - PROCESS | 32586 | Values: 65.0 66.0 66.0 68.0 67.0 67.0 67.0 66.0 66.0 67.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.50 stddev:0.97 (1.2%) stddev-sans-first:1.01 14:44:13 INFO - PROCESS | 32586 | Values: 78.0 80.0 80.0 79.0 78.0 78.0 79.0 77.0 78.0 78.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#11] stanford-crypto-ccm Cycles:10 Average:113.80 Median:113.50 stddev:3.49 (3.1%) stddev-sans-first:3.70 14:44:13 INFO - PROCESS | 32586 | Values: 114.0 113.0 111.0 122.0 113.0 113.0 114.0 117.0 110.0 111.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.60 Median:144.00 stddev:4.53 (3.1%) stddev-sans-first:4.51 14:44:13 INFO - PROCESS | 32586 | Values: 146.0 136.0 142.0 143.0 144.0 136.0 146.0 145.0 144.0 134.0 14:44:13 INFO - PROCESS | 32586 | 14:44:13 INFO - PROCESS | 32586 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.75 (2.6%) stddev-sans-first:1.80 14:44:13 INFO - PROCESS | 32586 | Values: 68.0 70.0 68.0 66.0 65.0 66.0 67.0 68.0 66.0 64.0 14:44:13 INFO - PROCESS | 32586 | -------- Summary: end -------- 14:44:13 INFO - PROCESS | 32586 | 14:44:14 INFO - TEST-INFO | 32586: exit 0 14:44:14 INFO - TEST-OK | kraken | took 59793ms 14:44:14 INFO - SUITE-END | took 1170s 14:44:14 INFO - Completed test suite (00:19:30) 14:44:14 INFO - javascript benchmark 14:44:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3296.175956010997, 3332.150301673073, 3350.5811773528294, 3353.6143343515487, 3378.898633041009, 5363.517283444489, 5420.485053919876, 5447.836564903059, 5465.890682186354, 5482.424345443731, 5424.267723857278, 5448.182772584114, 5463.754131064102, 5470.863228419282, 5471.917921231185, 4944.233643785201, 5009.949900500994, 5069.9493005070035, 5094.235864620299, 5125.769340379673, 4926.581240594536, 4942.579880710144, 4977.975110124463, 5033.345665063555, 5035.093683137034, 5024.422191447976, 5082.440931497551, 5110.565601923841, 5130.153524668425, 5130.4356520782685, 5023.196288593807, 5085.98280343929, 5096.643234973535, 5100.311457953203, 5102.846914592549, 4848.587870031051, 4868.78090485929, 4949.653524253304, 4951.678140920829, 4989.725565093919, 5299.814506492255, 5304.230886521472, 5308.734563271821, 5313.44208858072, 5341.626086173969, 5904.321003084614, 5907.970460147715, 5909.143174239711, 5909.143174239754, 5909.793157239476, 5746.770129194827, 5876.6180198286975, 5882.588218824684, 5941.346451890288, 5962.135490353874, 5490.615656904019, 5499.972500137514, 5502.504774570268, 5504.504594586467, 5506.724663766796, 5767.509761670305, 5939.4951429129005, 5996.8800623988145, 5998.670073145931, 6005.459508644243, 5754.424557544212, 5772.249607550992, 5773.162891380726, 5799.101139323411, 5805.10020946754, 5818.941810581925, 5857.912131318034, 5860.062390017577, 5864.354920958691, 5878.412158784087, 5677.148427735872, 5723.484886360247, 5809.970950145223, 5815.185873977646, 5815.214945982323, 5816.302043754692, 5828.300603927556, 5835.533157347402, 5838.591298609142, 5870.618409803435, 4461.598456138963, 4464.062546865194, 4468.419105516262, 4469.888252793641, 4470.994026344047, 4009.3985902114914, 4012.117334186474, 4038.6163314485666, 4056.0873803394, 4083.387491876183, 5589.385167631557, 5604.439556044363, 5610.747516361774, 5626.971865140648, 5633.098704207389, 5910.852228694231, 5914.0241860093465, 5917.55618328627, 5918.8816223675285, 5921.911171332434, 5458.017556839807, 5571.888562228733, 5576.414476479992, 5609.775608975595, 5657.349404818417, 5009.874753131201, 5052.8484145475695, 5074.5179207975925, 5075.289459475676, 5077.314562534085, 6088.512918966472, 6132.877342453126, 6138.907916381258, 6140.109684095871, 6163.96918015407, 5779.711014449261, 5840.065589505659, 5894.204282421818, 5905.232319798399, 5913.994620914369, 6097.176881120992, 6107.725152368243, 6108.450239478469, 6110.908336374869, 6122.2959359674205, 5787.681677507778, 5797.623154495113, 5797.826065218051, 5799.681017544076, 5801.8549536261935, 5795.275590551181, 5886.6173698709445, 5915.645061296336, 5923.259592550931, 5953.3153687324775, 5700.116481945305, 5711.714414279352, 5721.313442386774, 5726.484616384545, 5744.942550574441, 5585.413531579288, 5730.226419433323, 5733.4266573344, 5736.397678243891, 5744.109663002241, 5641.238432811518, 5663.008973429715, 5693.572982026448, 5698.8290351289525, 5722.6852523109965, 5721.485066344049, 5757.510611598061, 5757.97121014409, 5761.0, 5764.193012978102, 5539.058360078877, 5555.166724991283, 5621.2411324472305, 5624.493795558419, 5652.434756524314], "unit": "score", "name": "dojo.html", "value": 5419.142412241057}, {"lowerIsBetter": false, "replicates": [480.1117931826122, 534.6177483099588, 539.9055165346065, 556.8914061757956, 562.7158285066041, 30347.544786828214, 38336.0, 38967.805160974225, 39096.41355379664, 39106.80446597763, 42915.14169716612, 43626.127477450515, 43629.56370436295, 43651.3452298215, 43701.562984370146, 8940.776480587989, 9164.266858651325, 9166.22087122592, 9173.95413022934, 9179.586918588646, 8902.154295341932, 8940.821183576325, 9009.234215091692, 9051.818963620724, 9251.0, 9134.36059475837, 9217.585208665627, 9245.352825302232, 9317.906820931772, 9318.534073296341, 9250.213731832802, 9325.0, 9332.206762425201, 9339.066093390675, 9343.0, 9034.54827258641, 9152.54237288133, 9220.40067395624, 9238.214751746109, 9243.90756092444, 42070.0, 42453.0, 42506.0, 42560.14879702389, 42622.360664589745, 3705.962940370589, 3830.4254361845947, 4403.867883963454, 4426.380306757057, 4492.034212644265, 33120.668793312, 33166.17084572905, 33199.170020749676, 33318.50022249668, 33816.492752608734, 4202.222588821078, 4288.614024737789, 4357.085012147453, 4374.715643483163, 4386.232409328387, 277436.0, 277445.0, 278029.6098519515, 279881.0, 280133.0, 62325.0, 63305.68347158235, 63322.683386583696, 63343.6832815833, 63714.0, 67833.66083169651, 82300.58849705714, 83103.0, 83334.58332708418, 83577.58211209027, 17691.292348305924, 17790.644187116184, 17875.37436189727, 17932.462026139237, 17999.2800287987, 13198.73602527944, 13334.133281336683, 13369.064165508516, 13375.93312033453, 13386.732265354638, 22824.543509129726, 23159.7684023161, 23314.184003559792, 23348.182813601783, 23405.297841064796, 7790.9220907790195, 7911.406644501571, 8125.9187408126345, 8131.308838748772, 8226.629801658939, 1019.4393083803878, 1087.423665457309, 1094.7536804218987, 1106.7122548137543, 1151.0388825330774, 30309.848450757607, 30407.23981900426, 30531.236719081757, 30839.074827754754, 30998.070057898298, 1071.2929466552039, 1101.5215764529808, 1160.6634076118, 1177.1936223686803, 1233.0690328801697, 15764.448244311394, 15816.92091539558, 16093.275802588912, 17016.65966680684, 17108.572285692957, 428333.0, 434747.0, 435797.0, 435800.0, 437725.0, 61948.0, 62458.37541624616, 62638.0, 62733.68633156896, 62751.37248627455, 1321.478016183602, 1454.5854431486975, 1499.212913220568, 1531.7166324230054, 1538.5845821628097, 30208.891269416385, 30215.244618884703, 32809.67190328162, 32891.83554082214, 33499.33001340008, 48000.27999580079, 48133.0, 48333.5166648329, 48542.757286213346, 48594.27108593303, 208453.0, 211704.0, 212980.0, 213264.0, 213853.0, 30984.690153099084, 35143.297134057684, 35419.64580354266, 35599.64400355963, 36149.27701446009, 47892.0, 48809.26786098282, 49312.260316096006, 49853.0, 50012.24981625351, 40474.797626011685, 41073.0, 41336.1732765349, 41888.79055604825, 42110.78944605257, 38994.4150837732, 39061.41407878941, 39848.601513985646, 40095.599044009185, 40635.59364406318, 38850.4172437408, 39874.601253987086, 39912.0, 39958.2008359837, 39969.0, 34982.901025937506, 35682.64317356897, 35838.283234335686, 36364.27271454609, 36907.0, 27557.31106722348, 27919.44161116807, 27977.72022279751, 28034.579481308203, 28120.156395308175], "unit": "score", "name": "ext.html", "value": 20103.453479033833}, {"lowerIsBetter": false, "replicates": [355.4384073164401, 373.8915714442811, 374.51313292719476, 386.65780784006165, 390.48066072124044, 17082.31670733169, 18174.90912545437, 19071.809281907175, 19587.412377628694, 19592.70610940837, 17413.216405261763, 17687.46937591871, 18286.0, 18321.08394580269, 18326.175322110503, 5644.6613203207735, 5780.53755699543, 5805.854853628651, 5813.2152159458565, 5819.883602327972, 4182.602652747984, 5757.712114394284, 6125.663088530129, 6306.432421082101, 6342.873142537146, 6259.37406259375, 6275.717592708339, 6300.0, 6307.463865571432, 6309.495240380781, 6144.907826382608, 6187.876242475148, 6327.746890124389, 6339.746410143589, 6340.112384266206, 3858.6527212551005, 5456.91814622781, 5590.301212348457, 5657.179708942181, 5664.0, 21349.57300853974, 21692.783072169233, 21898.343049708375, 22328.441788955242, 22329.888350558307, 2367.893444794988, 2432.5621388150125, 2433.3065076453126, 2468.123816045314, 2528.671272734551, 13691.0, 13920.30398480072, 14083.577492675236, 14241.359138838778, 14403.135811851322, 1864.1797609051973, 1923.9038048097539, 1935.1872213670292, 1951.219512195119, 1977.6440240756658, 65415.67292163556, 66089.0, 66177.66911165461, 66735.66632166857, 67214.9917751239, 10209.846852297222, 10511.0, 10582.470876456146, 10774.084202842847, 11083.612073577386, 14799.482018129314, 14894.776578351333, 15036.323365448581, 15038.097714137186, 15043.398264069314, 8163.918360816316, 8309.086000539935, 8360.372972027122, 8365.498070115691, 8397.496150231005, 8132.837343253102, 8166.550839703873, 8207.138250483733, 8217.58912054395, 8284.171582841667, 6235.937640623626, 6273.12176295319, 6314.431701146918, 6333.461655759312, 6375.10748495211, 1787.7675902132898, 1811.9003454810113, 1882.6799444094536, 1883.6986082226779, 1913.7703475582741, 945.4091193004373, 970.5923512124924, 972.7957129002847, 1096.446294621211, 1140.5950887435008, 17358.305667773147, 17702.468925932244, 17779.377721779936, 17873.37443189508, 18520.073996300132, 1036.6527213383602, 1066.1524088349781, 1073.7369344510646, 1102.327580176092, 1123.2811000959393, 10271.435071071162, 10712.73218169552, 10758.139348852073, 10762.461876906124, 10886.782264354668, 478760.0, 488356.0, 493186.0, 499505.0, 500163.0, 67352.66323668449, 69416.0, 69583.95624065644, 69641.65179174174, 70787.0, 1066.0991462214417, 1069.9144068474504, 1084.35480888871, 1091.028984204059, 1104.364990130662, 16242.593935151242, 16252.837471625606, 16391.098489583186, 16393.754093688367, 16436.917815410845, 33503.66496335006, 33635.49546756849, 35088.47367289442, 35222.47166292559, 35522.467162992056, 44591.33113003243, 46131.0, 46559.0, 46813.0, 47278.34525791581, 8610.0, 8833.07252738479, 8893.688720894737, 8897.73306800797, 9052.728418147466, 13167.473301068234, 13371.0, 13663.385147668578, 13724.725505490034, 13797.310134493035, 11302.095832333229, 11534.250273732181, 11550.711232219262, 11655.30068195911, 11895.82156267674, 11676.182667213214, 11835.0, 11850.76298474043, 11895.940520297343, 11950.641480755592, 11672.474738636613, 11679.182457227913, 11761.353125578175, 11971.281723096643, 12268.754624907631, 8686.0, 8739.082396348545, 8876.556172191236, 8885.0, 8997.0, 11037.558497660004, 11136.164787640797, 11234.101271898066, 11523.884761152281, 11604.129690273094], "unit": "score", "name": "jquery.html", "value": 9161.39817777286}, {"lowerIsBetter": false, "replicates": [1480.1341215388998, 1572.3474757975437, 1579.8973066750661, 1820.2173065581803, 1973.6348775476529, 7972.561509116997, 8149.388795840314, 8154.225348591889, 8160.551169685665, 8167.305779008784, 8219.260266576008, 8391.24478796908, 8394.958025209866, 8398.370122240825, 8403.327733781298, 2434.573949558829, 2472.5796614575474, 2475.096589744739, 2475.356407334088, 2476.9752302477013, 2435.8051355891484, 2514.270861450186, 2515.811314151437, 2531.0508559290265, 2536.759007894247, 2465.2604218734396, 2469.8888550015295, 2494.625806129077, 2496.500699860026, 2497.5504409206337, 2478.6405971134177, 2488.5645012122895, 2491.426971796479, 2498.5502609530276, 2511.598144296913, 2482.491089326684, 2512.032867346085, 2528.5448619248527, 2529.72173060965, 2569.897204111833, 8280.461769984931, 8327.625256863455, 8330.291925186366, 8331.0, 8336.749897503025, 5178.171492561172, 5367.221752845816, 5371.4897084776885, 5372.0, 5374.113271310229, 3302.983485082559, 3334.61651910031, 3352.8155951422664, 3373.628900820908, 3390.8135052572097, 1032.045358043814, 1069.101954358335, 1071.1537885070784, 1076.7954088723118, 1086.5490821309147, 11085.889141108566, 11323.716907077389, 11379.089672826154, 11385.0, 11386.202965792398, 4802.975985120052, 4822.300766388854, 4839.563909624136, 4872.930054065916, 4906.509349065136, 10363.119134873621, 10364.119049880694, 10371.377717336984, 10382.221333400024, 10391.948040259751, 5494.478024587658, 5497.422770609029, 5499.945000550023, 5500.834974950758, 5503.724813759296, 4286.164197981426, 4796.976015119972, 4874.46380898101, 4889.119958407449, 4898.975505122452, 3914.941275880864, 4009.7393669411395, 4030.496187976503, 4038.8990275243355, 4051.372037334218, 1354.1604205392719, 1365.9317034148253, 1368.8904887608967, 1375.277979061001, 1375.6767159717458, 1452.0996981871308, 1457.3951809998732, 1465.413834466222, 1469.2433396800657, 1499.2054211268046, 7953.2842044216295, 8103.83792324162, 8109.107998120202, 8153.7553873383895, 8153.8776918346275, 1151.5796734192127, 1170.163333216737, 1217.4095563651622, 1224.8591411987557, 1258.3016425883538, 6289.119523266746, 6324.209473815773, 6343.9682801585695, 6379.904301435482, 6380.489560835122, 9845.212383009342, 10294.588216471408, 10333.173346132291, 10337.121344685636, 10338.844917326247, 9735.610575576897, 9959.900400996043, 10056.094951454405, 10128.088472037552, 10267.9486602568, 7855.921440785633, 7971.123176450586, 8019.679212831538, 8066.23370779775, 8076.8384632307025, 7675.61621918913, 7677.961610191914, 7730.7680769577, 7751.806204844924, 7762.262585054411, 8626.000618065415, 8668.176523230282, 8718.694845680371, 8847.336449766422, 8910.0, 8837.762713220025, 8968.506732129534, 8975.955120224357, 9184.724458266262, 9286.674966376144, 6520.119783829123, 6923.9307606923285, 7107.395871350993, 7248.746293879689, 7364.3003914628025, 8014.519128852287, 8028.718994835152, 8046.0344758629335, 8064.55644939534, 8074.959625202071, 7241.963790181016, 7442.0, 7475.0, 7566.470347075652, 7590.544567325978, 7241.660292845841, 7290.088738907637, 7419.925800741924, 7454.217307182667, 7556.584387858501, 7438.814029649302, 7486.0, 7504.3246107850555, 7509.1739908608915, 7509.586972716553, 6622.701978410887, 6883.174019117738, 6950.756723514653, 6958.582485050913, 6966.825829354104, 6813.625250611264, 6878.484113691393, 6910.550814197061, 6920.377166055079, 6922.7923162305215], "unit": "score", "name": "mootools.html", "value": 4904.083630418813}, {"lowerIsBetter": false, "replicates": [352.6191712950014, 354.4417542370767, 355.0201444014519, 357.64771699875615, 363.52559909318336, 5896.439838215368, 5905.468507834294, 5917.786853694987, 5938.762449502025, 5953.3748956359495, 5802.506786923117, 5872.354041055481, 5882.029465138247, 5882.14708867214, 5885.058390657496, 4343.804528796196, 4488.663350248728, 4616.722996620197, 4623.121606894696, 4638.095571363586, 4595.701279416827, 4614.884627884297, 4622.422197225347, 4630.0276941842085, 4636.211843986531, 4564.97717511412, 4587.174308624446, 4603.723776573416, 4605.4933957264675, 4615.053913947632, 4375.365571992059, 4508.188526065307, 4602.286645569942, 4613.746243956581, 4633.1660301145785, 4088.9386659200136, 4097.7541347518945, 4100.077482566398, 4102.958970410287, 4108.753474791522, 5659.037963546207, 5659.4340565943485, 5660.943390566124, 5664.433556644344, 5686.5735069869515, 5341.919871201935, 5342.866428339284, 5345.893082138336, 5352.545033672142, 5364.758585863646, 6199.411055949723, 6209.9068513972325, 6210.50315974721, 6212.782552610637, 6215.440610345046, 4424.889377765549, 4511.233090374644, 4511.977440112779, 4513.842015529441, 4514.503404625489, 6456.418922296969, 6469.417752402259, 6477.902831457532, 6489.383508566679, 6493.188351456068, 4601.930971035437, 4608.331791890158, 4610.077984403066, 4610.2854057621125, 4615.746133962597, 4692.7653617319, 4700.989287303178, 4702.177119004161, 4702.435707715028, 4717.150912835723, 5324.307839980777, 5326.0945639240645, 5335.62650614461, 5342.652727572696, 5343.7060961647485, 6130.386961303923, 6273.560850740496, 6285.402886725754, 6285.402886725754, 6289.685515724287, 1633.7059329320598, 1656.445090894564, 1659.991700041492, 1662.6342204715186, 1671.9247633856262, 1073.5974009746344, 1120.6581992492206, 1132.6885106595753, 1142.959996400122, 1155.0932517973351, 6050.878982420327, 6051.636901785819, 6066.726997285133, 6066.848328791727, 6074.848128796727, 6377.1390862233, 6388.201474815648, 6392.360763923663, 6397.808065758035, 6401.775937842153, 6032.758689652364, 6036.577439579188, 6037.456628903332, 6045.911735887495, 6050.515958723292, 3416.5046068319953, 3445.6898879101, 3452.58568971725, 3457.5505184325875, 3457.792532448061, 6425.164728585348, 6629.502787290876, 6641.302663220389, 6644.933550664431, 6656.134702488743, 6507.577007494498, 6512.283648798629, 6517.4134327910715, 6524.771632992917, 6545.967270163619, 6637.369449902251, 6640.037194606755, 6640.136782218377, 6658.966705166443, 6662.333766623396, 6366.586171898812, 6367.61794292344, 6369.649669268049, 6379.106925030592, 6388.329225431263, 6235.220597425322, 6287.71705273273, 6291.182146321132, 6297.2128483939505, 6464.773732919325, 6735.057092007025, 6739.898901516579, 6762.289959554176, 6769.763058292936, 6918.515703900679, 4541.069080838486, 4602.263637818067, 4603.148417542765, 4605.700629459075, 4610.677252592421, 6527.15147030883, 6531.11829902957, 6537.771178008747, 6538.803835884931, 6540.084388185753, 6341.841453963688, 6342.23893132827, 6344.365563443619, 6353.14232578596, 6354.046892966092, 6103.542234332354, 6349.936500634934, 6356.459700925473, 6366.840828979312, 6369.522285828674, 6180.412860778219, 6197.4732147767945, 6210.31686514474, 6210.689465526615, 6214.8135555933395, 6377.266614339411, 6378.075179099097, 6379.776707815204, 6392.20097487814, 6401.743930242738, 5909.113632955091, 6034.21555197839, 6038.969805150946, 6214.844628884314, 6226.377362263918], "unit": "score", "name": "prototype.html", "value": 4785.911429343081}, {"lowerIsBetter": false, "replicates": [778.4823092643393, 805.532790981231, 871.5555066915879, 894.2801045158647, 914.4513292024784, 15162.469313574027, 15318.387264509407, 15350.46273380432, 15379.154146521936, 15416.537503874888, 12465.875341246585, 14086.210143419263, 14218.075825071362, 14278.143311401323, 14306.642333941656, 906.714384968736, 921.1019256225194, 921.5714692667908, 923.949182794946, 924.6347692661394, 907.8275127725711, 908.8454962656331, 912.9360944733871, 913.3469569257979, 913.5295322908707, 944.593824655398, 951.8952915179359, 952.1716106986931, 954.3605784124618, 962.0523784072683, 942.0626476655772, 942.7030485397078, 943.7499062748377, 944.2681921510815, 956.6986399284237, 700.250731717063, 702.4450683959717, 704.851981083973, 709.8402859356655, 716.7240612364225, 13706.657333566642, 13706.725865482735, 13770.449182032708, 13771.449142034307, 13783.379747911367, 12221.266723996589, 12240.081993850408, 12332.075094367869, 12446.502139914393, 12457.065720070941, 10660.786784264348, 10693.144548436107, 10724.463776811128, 10928.125749939985, 11158.66524004273, 3789.829457674384, 3867.941980870289, 3870.767753934773, 3877.3602355611292, 3877.86427475037, 45602.771986140186, 49599.75200124012, 51299.48700512984, 53324.73337633326, 53457.0, 11311.208215424842, 11375.089992800557, 11463.484143213574, 11478.59824906141, 11573.074154067654, 17270.395536156175, 19273.807261927202, 19514.0, 19524.316648917218, 19866.304679336445, 8496.320294376435, 8591.398602097917, 8618.138186181457, 8688.869666955, 8972.775680607907, 4836.564709176191, 4900.681455705368, 4918.5573298403315, 4938.777755001033, 4985.626078044161, 3367.410703126943, 3381.1547113221695, 3386.7629265951145, 3388.8305584720665, 3393.5588373511778, 643.411278680012, 646.7348387161242, 647.2427260105687, 648.4002297874541, 650.5381179362611, 595.9076343166817, 625.7152995387088, 630.9463695585927, 674.8076798112514, 722.5086940880252, 7855.685772569148, 8166.781186827175, 8188.754337369888, 8351.707690230935, 8440.366972477088, 718.6730037832878, 738.2027410396759, 744.8919906613619, 752.3905636434506, 759.8556274307974, 3958.929707379128, 4015.0363912661337, 4036.495438070241, 4053.9594604054173, 4114.897127571775, 55671.72164139153, 56272.0, 56803.43196568064, 59156.704216479506, 60324.39675603276, 46915.0, 46968.295475567895, 47380.0, 49611.751941240065, 50079.744816586805, 45060.32409513794, 45198.32202516965, 45614.77192614082, 45689.771551142694, 45887.0, 8924.509151996703, 9074.637014519609, 9188.40275382098, 9339.066093390607, 9375.578098985425, 30877.69122308748, 31311.21721956969, 33522.32955340928, 35944.0, 36613.0, 43500.78249608732, 43896.34155487734, 44425.55574444214, 44486.555134448245, 44586.55413445824, 12182.329971851634, 12324.383780811102, 12377.62867113988, 12568.371581421075, 12612.49550017989, 13293.401796918968, 13355.3990070449, 13645.181289122684, 13758.518451854137, 14185.574432767033, 12251.264924104582, 12428.689282767642, 12543.184692994926, 13039.217646941213, 13046.0, 12214.14500984958, 12727.299998500172, 12732.745345093232, 13143.802842957171, 13432.798508022192, 11998.880011199777, 12226.0, 12292.81560776607, 12630.810537842124, 12807.423665934868, 10286.177105831664, 10293.794124117625, 10493.213009024506, 10746.570137194425, 10851.294665846695, 10457.0, 10700.785984280115, 10789.40658263803, 10799.514021868878, 10855.077318428022], "unit": "score", "name": "yui.html", "value": 6761.192731413905}], "name": "dromaeo_css", "value": 7355.709051628809}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 112.0, 110.0, 110.0, 99.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [161.0, 128.0, 159.0, 168.0, 128.0, 156.0, 150.0, 128.0, 171.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 162.0, 161.0, 160.0, 164.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 75.0, 164.0, 76.0, 77.0, 74.0, 75.0, 161.0, 75.0], "unit": "score", "name": "audio-fft", "value": 92.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 135.0, 94.0, 93.0, 93.0, 140.0, 93.0, 93.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 118.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [59.0, 55.0, 58.0, 55.0, 56.0, 55.0, 57.0, 59.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 80.0, 79.0, 78.0, 78.0, 79.0, 77.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.5}, {"lowerIsBetter": true, "replicates": [114.0, 113.0, 111.0, 122.0, 113.0, 113.0, 114.0, 117.0, 110.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.8}, {"lowerIsBetter": true, "replicates": [146.0, 136.0, 142.0, 143.0, 144.0, 136.0, 146.0, 145.0, 144.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.6}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 66.0, 65.0, 66.0, 67.0, 68.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1499.3999999999999}]} 14:44:14 INFO - Return code: 0 14:44:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:44:14 INFO - # TBPL SUCCESS # 14:44:14 INFO - Running post-action listener: _resource_record_post_action 14:44:14 INFO - Running post-run listener: _resource_record_post_run 14:44:15 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 16384; Write bytes: 459894784; Read time: 32; Write time: 388968 14:44:15 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237359104; Read time: 0; Write time: 276576 14:44:16 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 222220288; Read time: 32; Write time: 112368 14:44:16 INFO - Running post-run listener: _upload_blobber_files 14:44:16 INFO - Blob upload gear active. 14:44:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:16 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 14:44:16 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:44:16 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:44:16 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:44:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:44:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:17 INFO - (blobuploader) - INFO - Done attempting. 14:44:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:44:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:44:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:18 INFO - (blobuploader) - INFO - Done attempting. 14:44:18 INFO - (blobuploader) - INFO - Iteration through files over. 14:44:18 INFO - Return code: 0 14:44:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:44:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:44:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ebdec40e72f3157df63d5b25e743de2e2eb1d4ac098f5581dbb74805a1e432fe6aaf6640828b5c3c55ae9e2042a50c5226c5c49bb482f1479a728ddb2b1b48be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c67e0d4ac9bc60b0152666970682db578a4553e416062012548fb1fd45b9927d6d498180858420975b5f5118eea25a2adfa77d7000c2e3da9c585b5b7f9e0ca4"} 14:44:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:44:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:44:18 INFO - Contents: 14:44:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ebdec40e72f3157df63d5b25e743de2e2eb1d4ac098f5581dbb74805a1e432fe6aaf6640828b5c3c55ae9e2042a50c5226c5c49bb482f1479a728ddb2b1b48be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c67e0d4ac9bc60b0152666970682db578a4553e416062012548fb1fd45b9927d6d498180858420975b5f5118eea25a2adfa77d7000c2e3da9c585b5b7f9e0ca4"} 14:44:18 INFO - Running post-run listener: copy_logs_to_upload_dir 14:44:18 INFO - Copying logs to upload dir... 14:44:18 INFO - mkdir: /builds/slave/test/build/upload/logs 14:44:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.220603 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-16 14:44:18.000458) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 14:44:18.003894) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525 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-Beta/sha512/ebdec40e72f3157df63d5b25e743de2e2eb1d4ac098f5581dbb74805a1e432fe6aaf6640828b5c3c55ae9e2042a50c5226c5c49bb482f1479a728ddb2b1b48be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c67e0d4ac9bc60b0152666970682db578a4553e416062012548fb1fd45b9927d6d498180858420975b5f5118eea25a2adfa77d7000c2e3da9c585b5b7f9e0ca4"} build_url:https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/DDnb19LsRLWP3Ujfwa4SBA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ebdec40e72f3157df63d5b25e743de2e2eb1d4ac098f5581dbb74805a1e432fe6aaf6640828b5c3c55ae9e2042a50c5226c5c49bb482f1479a728ddb2b1b48be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c67e0d4ac9bc60b0152666970682db578a4553e416062012548fb1fd45b9927d6d498180858420975b5f5118eea25a2adfa77d7000c2e3da9c585b5b7f9e0ca4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 14:44:18.028760) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:44:18.029254) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463430499.288189-1477019525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004640 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:44:18.111718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 14:44:18.112076) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 14:44:18.112474) ========= ========= Total master_lag: 0.20 =========