builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1462560633.04 results: success (0) buildid: 20160506063418 builduid: 101946d3d6c1492cb9298cdbcff7f8e9 revision: f485ca11d5d597330094223dd9cc9dfa035f7ab3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:33.039780) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:33.040178) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:33.040462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:33.080803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:33.081060) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 11:50:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.0M=0s 2016-05-06 11:50:33 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:33.232694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:33.233016) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019792 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:33.283534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:33.283850) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f485ca11d5d597330094223dd9cc9dfa035f7ab3 --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 f485ca11d5d597330094223dd9cc9dfa035f7ab3 --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=31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 11:50:33,448 truncating revision to first 12 chars 2016-05-06 11:50:33,448 Setting DEBUG logging. 2016-05-06 11:50:33,448 attempt 1/10 2016-05-06 11:50:33,448 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f485ca11d5d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 11:50:33,969 unpacking tar archive at: mozilla-beta-f485ca11d5d5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.808928 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:34.113323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:34.113618) ========= script_repo_revision: f485ca11d5d597330094223dd9cc9dfa035f7ab3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:34.113977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:34.114240) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 11:50:34.132035) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-06 11:50:34.132298) ========= /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=31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:50:34 INFO - MultiFileLogger online at 20160506 11:50:34 in /builds/slave/test 11:50:34 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 11:50:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:50:34 INFO - {'append_to_log': False, 11:50:34 INFO - 'base_work_dir': '/builds/slave/test', 11:50:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:50:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:50:34 INFO - 'branch': 'Mozilla-Beta', 11:50:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:50:34 INFO - 'config_files': ('talos/linux_config.py',), 11:50:34 INFO - 'default_actions': ('clobber', 11:50:34 INFO - 'read-buildbot-config', 11:50:34 INFO - 'download-and-extract', 11:50:34 INFO - 'populate-webroot', 11:50:34 INFO - 'create-virtualenv', 11:50:34 INFO - 'install', 11:50:34 INFO - 'run-tests'), 11:50:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:50:34 INFO - 'download_minidump_stackwalk': True, 11:50:34 INFO - 'download_symbols': 'ondemand', 11:50:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:50:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:50:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:50:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:50:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:50:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:50:34 INFO - 'installer_path': 'installer.exe', 11:50:34 INFO - 'log_level': 'info', 11:50:34 INFO - 'log_name': 'talos', 11:50:34 INFO - 'log_to_console': True, 11:50:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:50:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:50:34 INFO - 'opt_config_files': (), 11:50:34 INFO - 'pip_index': False, 11:50:34 INFO - 'sps_profile': False, 11:50:34 INFO - 'sps_profile_interval': 0, 11:50:34 INFO - 'suite': 'dromaeojs', 11:50:34 INFO - 'system_bits': '32', 11:50:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:50:34 INFO - 'title': 'talos-linux64-ix-014', 11:50:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:50:34 INFO - 'use_talos_json': True, 11:50:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:50:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:50:34 INFO - 'work_dir': 'build'} 11:50:34 INFO - ##### 11:50:34 INFO - ##### Running clobber step. 11:50:34 INFO - ##### 11:50:34 INFO - Running pre-action listener: _resource_record_pre_action 11:50:34 INFO - Running main action method: clobber 11:50:34 INFO - rmtree: /builds/slave/test/build 11:50:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:50:34 INFO - Running post-action listener: _resource_record_post_action 11:50:34 INFO - ##### 11:50:34 INFO - ##### Running read-buildbot-config step. 11:50:34 INFO - ##### 11:50:34 INFO - Running pre-action listener: _resource_record_pre_action 11:50:34 INFO - Running main action method: read_buildbot_config 11:50:34 INFO - Using buildbot properties: 11:50:34 INFO - { 11:50:34 INFO - "project": "", 11:50:34 INFO - "product": "firefox", 11:50:34 INFO - "script_repo_revision": "production", 11:50:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:50:34 INFO - "repository": "", 11:50:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:50:34 INFO - "buildid": "20160506063418", 11:50:34 INFO - "pgo_build": "True", 11:50:34 INFO - "basedir": "/builds/slave/test", 11:50:34 INFO - "buildnumber": 72, 11:50:34 INFO - "slavename": "talos-linux64-ix-014", 11:50:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:50:34 INFO - "platform": "ubuntu64_hw", 11:50:34 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:50:34 INFO - "branch": "mozilla-beta", 11:50:34 INFO - "repo_path": "releases/mozilla-beta", 11:50:34 INFO - "revision": "f485ca11d5d597330094223dd9cc9dfa035f7ab3", 11:50:34 INFO - "stage_platform": "linux64-pgo", 11:50:34 INFO - "builduid": "101946d3d6c1492cb9298cdbcff7f8e9", 11:50:34 INFO - "slavebuilddir": "test" 11:50:34 INFO - } 11:50:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 11:50:34 INFO - Running post-action listener: _resource_record_post_action 11:50:34 INFO - ##### 11:50:34 INFO - ##### Running download-and-extract step. 11:50:34 INFO - ##### 11:50:34 INFO - Running pre-action listener: _resource_record_pre_action 11:50:34 INFO - Running main action method: download_and_extract 11:50:34 INFO - mkdir: /builds/slave/test/build/tests 11:50:34 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')]} 11:50:34 INFO - https://queue.taskcluster.net/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:50:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:50:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:50:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/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 11:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/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 11:50:41 INFO - Downloaded 1412 bytes. 11:50:41 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:50:41 INFO - Using the following test package requirements: 11:50:41 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:50:41 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:50:41 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:50:41 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:50:41 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 11:50:41 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:50:41 INFO - u'jsshell-linux-x86_64.zip'], 11:50:41 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:50:41 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:50:41 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:50:41 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:50:41 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 11:50:41 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:50:41 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 11:50:41 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:50:41 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:50:41 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:50:41 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:50:41 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:50:41 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:50:41 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')]} 11:50:41 INFO - https://queue.taskcluster.net/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:50:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:50:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:50:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/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 11:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/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 11:50:43 INFO - Downloaded 23364668 bytes. 11:50:43 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'] 11:50:43 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 11:50:44 INFO - Return code: 0 11:50:44 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 11:50: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')]} 11:50:44 INFO - https://queue.taskcluster.net/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:50:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:50:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:50:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/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 11:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/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 11:50:58 INFO - Downloaded 23364668 bytes. 11:50:58 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'] 11:50:58 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 11:50:59 INFO - Return code: 0 11:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:59 INFO - https://queue.taskcluster.net/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:50:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:50:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:50:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/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 11:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/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 11:51:01 INFO - Downloaded 10845194 bytes. 11:51:01 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'] 11:51:01 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 11:51:01 INFO - Return code: 0 11:51: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')]} 11:51:01 INFO - https://queue.taskcluster.net/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:51:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:51:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:51:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/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 11:51:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/So4VtklCQf6wPLs0ORnexw/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 11:51:03 INFO - Downloaded 53796753 bytes. 11:51:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:51:03 INFO - mkdir: /builds/slave/test/properties 11:51:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:51:03 INFO - Writing to file /builds/slave/test/properties/build_url 11:51:03 INFO - Contents: 11:51:03 INFO - build_url:https://queue.taskcluster.net/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:51:03 INFO - Running post-action listener: _resource_record_post_action 11:51:03 INFO - Running post-action listener: set_extra_try_arguments 11:51:03 INFO - ##### 11:51:03 INFO - ##### Running populate-webroot step. 11:51:03 INFO - ##### 11:51:03 INFO - Running pre-action listener: _resource_record_pre_action 11:51:03 INFO - Running main action method: populate_webroot 11:51:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:51:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:51:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:51:03 INFO - '--tppagecycles', 11:51:03 INFO - '7'], 11:51:03 INFO - 'tests': ['tsvgm']}}, 11:51:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:51:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:51:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:51:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:51:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:51:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:51:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:03 INFO - 'talos_options': ['--e10s'], 11:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:03 INFO - 'tests': ['damp', 'tps']}, 11:51:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:03 INFO - 'talos_options': ['--e10s'], 11:51:03 INFO - 'tests': ['damp', 'tps']}, 11:51:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:51:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:51:03 INFO - 'other': {'tests': ['a11yr', 11:51:03 INFO - 'ts_paint', 11:51:03 INFO - 'tpaint', 11:51:03 INFO - 'sessionrestore', 11:51:03 INFO - 'sessionrestore_no_auto_restore', 11:51:03 INFO - 'tabpaint']}, 11:51:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:51:03 INFO - 'tests': ['a11yr', 11:51:03 INFO - 'ts_paint', 11:51:03 INFO - 'tpaint', 11:51:03 INFO - 'sessionrestore', 11:51:03 INFO - 'sessionrestore_no_auto_restore', 11:51:03 INFO - 'tabpaint']}, 11:51:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:51:03 INFO - 'tests': ['a11yr', 11:51:03 INFO - 'ts_paint', 11:51:03 INFO - 'tpaint', 11:51:03 INFO - 'sessionrestore', 11:51:03 INFO - 'sessionrestore_no_auto_restore', 11:51:03 INFO - 'tabpaint']}, 11:51:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:51:03 INFO - 'tests': ['a11yr', 11:51:03 INFO - 'ts_paint', 11:51:03 INFO - 'tpaint', 11:51:03 INFO - 'sessionrestore', 11:51:03 INFO - 'sessionrestore_no_auto_restore', 11:51:03 INFO - 'tabpaint']}, 11:51:03 INFO - 'other_l64': {'tests': ['a11yr', 11:51:03 INFO - 'ts_paint', 11:51:03 INFO - 'tpaint', 11:51:03 INFO - 'sessionrestore', 11:51:03 INFO - 'sessionrestore_no_auto_restore', 11:51:03 INFO - 'tabpaint']}, 11:51:03 INFO - 'other_nol64': {'tests': ['a11yr', 11:51:03 INFO - 'ts_paint', 11:51:03 INFO - 'tpaint', 11:51:03 INFO - 'sessionrestore', 11:51:03 INFO - 'sessionrestore_no_auto_restore', 11:51:03 INFO - 'tabpaint']}, 11:51:03 INFO - 'svgr': {'tests': ['tsvgx', 11:51:03 INFO - 'tsvgr_opacity', 11:51:03 INFO - 'tart', 11:51:03 INFO - 'tscrollx', 11:51:03 INFO - 'cart']}, 11:51:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:51:03 INFO - 'tests': ['tsvgx', 11:51:03 INFO - 'tsvgr_opacity', 11:51:03 INFO - 'tart', 11:51:03 INFO - 'tscrollx', 11:51:03 INFO - 'cart']}, 11:51:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:03 INFO - 'tests': ['tp5o']}, 11:51:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:03 INFO - 'talos_options': ['--e10s'], 11:51:03 INFO - 'tests': ['tp5o']}, 11:51:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:03 INFO - 'talos_options': ['--xperf_path', 11:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:03 INFO - 'tests': ['tp5n']}, 11:51:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:03 INFO - 'talos_options': ['--e10s', 11:51:03 INFO - '--xperf_path', 11:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:03 INFO - 'tests': ['tp5n']}}, 11:51:03 INFO - 'talos.zip': {'path': '', 11:51:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:51:03 INFO - Running post-action listener: _resource_record_post_action 11:51:03 INFO - ##### 11:51:03 INFO - ##### Running create-virtualenv step. 11:51:03 INFO - ##### 11:51:03 INFO - Running pre-action listener: _resource_record_pre_action 11:51:03 INFO - Running main action method: create_virtualenv 11:51:03 INFO - Creating virtualenv /builds/slave/test/build/venv 11:51:03 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 11:51:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:51:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:51:03 INFO - Using real prefix '/usr' 11:51:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:51:04 INFO - Installing distribute.............................................................................................................................................................................................done. 11:51:06 INFO - Installing pip.................done. 11:51:06 INFO - Return code: 0 11:51:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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 0x7f09cf249f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a87160>, '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 0x1a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a884f0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', '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 11:51: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 11:51: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 11:51:06 INFO - Using env: {'DISPLAY': ':0', 11:51:06 INFO - 'HOME': '/home/cltbld', 11:51:06 INFO - 'LANG': 'en_US.UTF-8', 11:51:06 INFO - 'LANGUAGE': 'en_US:en', 11:51:06 INFO - 'LOGNAME': 'cltbld', 11:51:06 INFO - 'MAIL': '/var/mail/cltbld', 11:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:06 INFO - 'MOZ_NO_REMOTE': '1', 11:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:06 INFO - 'NO_EM_RESTART': '1', 11:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:06 INFO - 'PWD': '/builds/slave/test', 11:51:06 INFO - 'SHELL': '/bin/bash', 11:51:06 INFO - 'SHLVL': '1', 11:51:06 INFO - 'TERM': 'linux', 11:51:06 INFO - 'TMOUT': '86400', 11:51:06 INFO - 'USER': 'cltbld', 11:51:06 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', 11:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:06 INFO - '_': '/tools/buildbot/bin/python'} 11:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51: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 11:51:06 INFO - Cleaning up... 11:51:06 INFO - Return code: 0 11:51:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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 0x7f09cf249f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a87160>, '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 0x1a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a884f0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', '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 11:51: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 11:51: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 11:51:06 INFO - Using env: {'DISPLAY': ':0', 11:51:06 INFO - 'HOME': '/home/cltbld', 11:51:06 INFO - 'LANG': 'en_US.UTF-8', 11:51:06 INFO - 'LANGUAGE': 'en_US:en', 11:51:06 INFO - 'LOGNAME': 'cltbld', 11:51:06 INFO - 'MAIL': '/var/mail/cltbld', 11:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:06 INFO - 'MOZ_NO_REMOTE': '1', 11:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:06 INFO - 'NO_EM_RESTART': '1', 11:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:06 INFO - 'PWD': '/builds/slave/test', 11:51:06 INFO - 'SHELL': '/bin/bash', 11:51:06 INFO - 'SHLVL': '1', 11:51:06 INFO - 'TERM': 'linux', 11:51:06 INFO - 'TMOUT': '86400', 11:51:06 INFO - 'USER': 'cltbld', 11:51:06 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', 11:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:06 INFO - '_': '/tools/buildbot/bin/python'} 11:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:06 INFO - Downloading/unpacking psutil>=0.7.1 11:51:06 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 11:51:06 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 11:51:06 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 11:51:06 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 11:51:06 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 11:51:06 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 11:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:51:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:08 INFO - Installing collected packages: psutil 11:51:08 INFO - Running setup.py install for psutil 11:51:08 INFO - building 'psutil._psutil_linux' extension 11:51:08 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 11:51:08 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 11:51:08 INFO - building 'psutil._psutil_posix' extension 11:51:08 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 11:51: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 11:51:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:09 INFO - Successfully installed psutil 11:51:09 INFO - Cleaning up... 11:51:09 INFO - Return code: 0 11:51:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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 0x7f09cf249f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a87160>, '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 0x1a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a884f0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', '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 11:51: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 11:51: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 11:51:09 INFO - Using env: {'DISPLAY': ':0', 11:51:09 INFO - 'HOME': '/home/cltbld', 11:51:09 INFO - 'LANG': 'en_US.UTF-8', 11:51:09 INFO - 'LANGUAGE': 'en_US:en', 11:51:09 INFO - 'LOGNAME': 'cltbld', 11:51:09 INFO - 'MAIL': '/var/mail/cltbld', 11:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:09 INFO - 'MOZ_NO_REMOTE': '1', 11:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:09 INFO - 'NO_EM_RESTART': '1', 11:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:09 INFO - 'PWD': '/builds/slave/test', 11:51:09 INFO - 'SHELL': '/bin/bash', 11:51:09 INFO - 'SHLVL': '1', 11:51:09 INFO - 'TERM': 'linux', 11:51:09 INFO - 'TMOUT': '86400', 11:51:09 INFO - 'USER': 'cltbld', 11:51:09 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', 11:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:09 INFO - '_': '/tools/buildbot/bin/python'} 11:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:51: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) 11:51:11 INFO - Installing collected packages: mozsystemmonitor 11:51:11 INFO - Running setup.py install for mozsystemmonitor 11:51:11 INFO - Successfully installed mozsystemmonitor 11:51:11 INFO - Cleaning up... 11:51:11 INFO - Return code: 0 11:51:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:11 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 0x7f09cf249f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a87160>, '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 0x1a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a884f0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', '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 11:51:11 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 11:51:11 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 11:51:11 INFO - Using env: {'DISPLAY': ':0', 11:51:11 INFO - 'HOME': '/home/cltbld', 11:51:11 INFO - 'LANG': 'en_US.UTF-8', 11:51:11 INFO - 'LANGUAGE': 'en_US:en', 11:51:11 INFO - 'LOGNAME': 'cltbld', 11:51:11 INFO - 'MAIL': '/var/mail/cltbld', 11:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:11 INFO - 'MOZ_NO_REMOTE': '1', 11:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:11 INFO - 'NO_EM_RESTART': '1', 11:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:11 INFO - 'PWD': '/builds/slave/test', 11:51:11 INFO - 'SHELL': '/bin/bash', 11:51:11 INFO - 'SHLVL': '1', 11:51:11 INFO - 'TERM': 'linux', 11:51:11 INFO - 'TMOUT': '86400', 11:51:11 INFO - 'USER': 'cltbld', 11:51:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', 11:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:11 INFO - '_': '/tools/buildbot/bin/python'} 11:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:11 INFO - Downloading/unpacking blobuploader==1.2.4 11:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:13 INFO - Downloading blobuploader-1.2.4.tar.gz 11:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:51:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:51:13 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 11:51:13 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 11:51:13 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 11:51:13 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 11:51:13 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 11:51:13 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 11:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:51:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:14 INFO - Downloading docopt-0.6.1.tar.gz 11:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:51:14 INFO - Installing collected packages: blobuploader, requests, docopt 11:51:14 INFO - Running setup.py install for blobuploader 11:51:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:51:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:51:14 INFO - Running setup.py install for requests 11:51:14 INFO - Running setup.py install for docopt 11:51:14 INFO - Successfully installed blobuploader requests docopt 11:51:14 INFO - Cleaning up... 11:51:14 INFO - Return code: 0 11:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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 0x7f09cf249f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a87160>, '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 0x1a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a884f0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', '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 11:51: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 11:51: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 11:51:15 INFO - Using env: {'DISPLAY': ':0', 11:51:15 INFO - 'HOME': '/home/cltbld', 11:51:15 INFO - 'LANG': 'en_US.UTF-8', 11:51:15 INFO - 'LANGUAGE': 'en_US:en', 11:51:15 INFO - 'LOGNAME': 'cltbld', 11:51:15 INFO - 'MAIL': '/var/mail/cltbld', 11:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:15 INFO - 'MOZ_NO_REMOTE': '1', 11:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:15 INFO - 'NO_EM_RESTART': '1', 11:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:15 INFO - 'PWD': '/builds/slave/test', 11:51:15 INFO - 'SHELL': '/bin/bash', 11:51:15 INFO - 'SHLVL': '1', 11:51:15 INFO - 'TERM': 'linux', 11:51:15 INFO - 'TMOUT': '86400', 11:51:15 INFO - 'USER': 'cltbld', 11:51:15 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', 11:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:15 INFO - '_': '/tools/buildbot/bin/python'} 11:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:15 INFO - Running setup.py (path:/tmp/pip-5_zXHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:15 INFO - Running setup.py (path:/tmp/pip-CcCg3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:15 INFO - Running setup.py (path:/tmp/pip-4KbVEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:15 INFO - Running setup.py (path:/tmp/pip-hoCsFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:15 INFO - Running setup.py (path:/tmp/pip-Vl3UmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:15 INFO - Running setup.py (path:/tmp/pip-vWr2lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:15 INFO - Running setup.py (path:/tmp/pip-91cFOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:15 INFO - Running setup.py (path:/tmp/pip-tvuqyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:15 INFO - Running setup.py (path:/tmp/pip-bPjedw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:15 INFO - Running setup.py (path:/tmp/pip-bLGp32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:15 INFO - Running setup.py (path:/tmp/pip-Of3W9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:15 INFO - Running setup.py (path:/tmp/pip-8Zvdpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:16 INFO - Running setup.py (path:/tmp/pip-pArbie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:16 INFO - Running setup.py (path:/tmp/pip-yIQJ4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:16 INFO - Running setup.py (path:/tmp/pip-hGyYkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:16 INFO - Running setup.py (path:/tmp/pip-34Ttja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:16 INFO - Running setup.py (path:/tmp/pip-yJHSOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:51:16 INFO - Running setup.py install for manifestparser 11:51:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:51:16 INFO - Running setup.py install for mozcrash 11:51:16 INFO - Running setup.py install for mozdebug 11:51:16 INFO - Running setup.py install for mozdevice 11:51:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:51:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:51:16 INFO - Running setup.py install for mozfile 11:51:16 INFO - Running setup.py install for mozhttpd 11:51:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Running setup.py install for mozinfo 11:51:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Running setup.py install for mozInstall 11:51:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Running setup.py install for mozleak 11:51:17 INFO - Running setup.py install for mozlog 11:51:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Running setup.py install for moznetwork 11:51:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Running setup.py install for mozprocess 11:51:17 INFO - Running setup.py install for mozprofile 11:51:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Running setup.py install for mozrunner 11:51:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:51:17 INFO - Running setup.py install for mozscreenshot 11:51:17 INFO - Running setup.py install for moztest 11:51:18 INFO - Running setup.py install for mozversion 11:51:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:51:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:51:18 INFO - Cleaning up... 11:51:18 INFO - Return code: 0 11:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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 0x7f09cf249f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a87160>, '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 0x1a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a884f0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', '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 11:51: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 11:51: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 11:51:18 INFO - Using env: {'DISPLAY': ':0', 11:51:18 INFO - 'HOME': '/home/cltbld', 11:51:18 INFO - 'LANG': 'en_US.UTF-8', 11:51:18 INFO - 'LANGUAGE': 'en_US:en', 11:51:18 INFO - 'LOGNAME': 'cltbld', 11:51:18 INFO - 'MAIL': '/var/mail/cltbld', 11:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:18 INFO - 'MOZ_NO_REMOTE': '1', 11:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:18 INFO - 'NO_EM_RESTART': '1', 11:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:18 INFO - 'PWD': '/builds/slave/test', 11:51:18 INFO - 'SHELL': '/bin/bash', 11:51:18 INFO - 'SHLVL': '1', 11:51:18 INFO - 'TERM': 'linux', 11:51:18 INFO - 'TMOUT': '86400', 11:51:18 INFO - 'USER': 'cltbld', 11:51:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', 11:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:18 INFO - '_': '/tools/buildbot/bin/python'} 11:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:18 INFO - Running setup.py (path:/tmp/pip-5Oq25F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:18 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)) 11:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:18 INFO - Running setup.py (path:/tmp/pip-S3c4jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:18 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)) 11:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:18 INFO - Running setup.py (path:/tmp/pip-_iqY0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:18 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)) 11:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:18 INFO - Running setup.py (path:/tmp/pip-lNvSBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:18 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)) 11:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:18 INFO - Running setup.py (path:/tmp/pip-z497uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:18 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)) 11:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:18 INFO - Running setup.py (path:/tmp/pip-CJi6BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:18 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)) 11:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:18 INFO - Running setup.py (path:/tmp/pip-1wPCuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:18 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)) 11:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:18 INFO - Running setup.py (path:/tmp/pip-DuvPki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:18 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)) 11:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:18 INFO - Running setup.py (path:/tmp/pip-LAEYPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51: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)) 11:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:19 INFO - Running setup.py (path:/tmp/pip-3b6g1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51: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)) 11:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:19 INFO - Running setup.py (path:/tmp/pip-EF0Zax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51: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)) 11:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:19 INFO - Running setup.py (path:/tmp/pip-UsVNHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:19 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)) 11:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:19 INFO - Running setup.py (path:/tmp/pip-XEpKLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:19 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)) 11:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:19 INFO - Running setup.py (path:/tmp/pip-t61OUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:19 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)) 11:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:19 INFO - Running setup.py (path:/tmp/pip-AgYIfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:19 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)) 11:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:19 INFO - Running setup.py (path:/tmp/pip-zGNlyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:19 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)) 11:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:19 INFO - Running setup.py (path:/tmp/pip-NqK3gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:19 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)) 11:51:19 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)) 11:51:19 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)) 11:51:19 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)) 11:51:19 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)) 11:51:19 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)) 11:51:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:51:19 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 11:51:19 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 11:51:19 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 11:51:19 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 11:51:19 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 11:51:19 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 11:51:21 INFO - Downloading blessings-1.6.tar.gz 11:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:51:21 INFO - Installing collected packages: blessings 11:51:21 INFO - Running setup.py install for blessings 11:51:21 INFO - Successfully installed blessings 11:51:21 INFO - Cleaning up... 11:51:21 INFO - Return code: 0 11:51:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:51:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:21 INFO - Reading from file tmpfile_stdout 11:51:21 INFO - Current package versions: 11:51:21 INFO - argparse == 1.2.1 11:51:21 INFO - blessings == 1.6 11:51:21 INFO - blobuploader == 1.2.4 11:51:21 INFO - docopt == 0.6.1 11:51:21 INFO - manifestparser == 1.1 11:51:21 INFO - mozInstall == 1.12 11:51:21 INFO - mozcrash == 0.17 11:51:21 INFO - mozdebug == 0.1 11:51:21 INFO - mozdevice == 0.48 11:51:21 INFO - mozfile == 1.2 11:51:21 INFO - mozhttpd == 0.7 11:51:21 INFO - mozinfo == 0.9 11:51:21 INFO - mozleak == 0.1 11:51:21 INFO - mozlog == 3.1 11:51:21 INFO - moznetwork == 0.27 11:51:21 INFO - mozprocess == 0.22 11:51:21 INFO - mozprofile == 0.28 11:51:21 INFO - mozrunner == 6.11 11:51:21 INFO - mozscreenshot == 0.1 11:51:21 INFO - mozsystemmonitor == 0.0 11:51:21 INFO - moztest == 0.7 11:51:21 INFO - mozversion == 1.4 11:51:21 INFO - psutil == 3.1.1 11:51:21 INFO - requests == 1.2.3 11:51:21 INFO - wsgiref == 0.1.2 11:51:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:21 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')]} 11:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:21 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')]} 11:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:21 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 0x7f09cf249f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a87160>, '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 0x1a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a884f0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', '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 11:51:21 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 11:51:21 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 11:51:21 INFO - Using env: {'DISPLAY': ':0', 11:51:21 INFO - 'HOME': '/home/cltbld', 11:51:21 INFO - 'LANG': 'en_US.UTF-8', 11:51:21 INFO - 'LANGUAGE': 'en_US:en', 11:51:21 INFO - 'LOGNAME': 'cltbld', 11:51:21 INFO - 'MAIL': '/var/mail/cltbld', 11:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:21 INFO - 'MOZ_NO_REMOTE': '1', 11:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:21 INFO - 'NO_EM_RESTART': '1', 11:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:21 INFO - 'PWD': '/builds/slave/test', 11:51:21 INFO - 'SHELL': '/bin/bash', 11:51:21 INFO - 'SHLVL': '1', 11:51:21 INFO - 'TERM': 'linux', 11:51:21 INFO - 'TMOUT': '86400', 11:51:21 INFO - 'USER': 'cltbld', 11:51:21 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', 11:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:21 INFO - '_': '/tools/buildbot/bin/python'} 11:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51: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)) 11:51: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)) 11:51: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)) 11:51: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)) 11:51: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)) 11:51: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)) 11:51: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)) 11:51: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)) 11:51: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)) 11:51: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)) 11:51: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)) 11:51:22 INFO - Cleaning up... 11:51:22 INFO - Return code: 0 11:51:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:22 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 0x7f09cf249f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a87160>, '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 0x1a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a884f0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', '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 11:51:22 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 11:51:22 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 11:51:22 INFO - Using env: {'DISPLAY': ':0', 11:51:22 INFO - 'HOME': '/home/cltbld', 11:51:22 INFO - 'LANG': 'en_US.UTF-8', 11:51:22 INFO - 'LANGUAGE': 'en_US:en', 11:51:22 INFO - 'LOGNAME': 'cltbld', 11:51:22 INFO - 'MAIL': '/var/mail/cltbld', 11:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:22 INFO - 'MOZ_NO_REMOTE': '1', 11:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:22 INFO - 'NO_EM_RESTART': '1', 11:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:22 INFO - 'PWD': '/builds/slave/test', 11:51:22 INFO - 'SHELL': '/bin/bash', 11:51:22 INFO - 'SHLVL': '1', 11:51:22 INFO - 'TERM': 'linux', 11:51:22 INFO - 'TMOUT': '86400', 11:51:22 INFO - 'USER': 'cltbld', 11:51:22 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', 11:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:22 INFO - '_': '/tools/buildbot/bin/python'} 11:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:22 INFO - Downloading/unpacking jsonschema 11:51:22 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 11:51:22 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 11:51:22 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 11:51:22 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 11:51:22 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 11:51:22 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 11:51:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:51:24 INFO - Downloading/unpacking functools32 (from jsonschema) 11:51:24 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 11:51:24 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 11:51:24 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 11:51:24 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 11:51:24 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 11:51:24 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 11:51:24 INFO - Downloading functools32-3.2.3-2.tar.gz 11:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:51:24 INFO - warning: no files found matching '*.txt' 11:51:24 INFO - no previously-included directories found matching 'build' 11:51:24 INFO - no previously-included directories found matching 'dist' 11:51:24 INFO - no previously-included directories found matching '.git*' 11:51:24 INFO - Installing collected packages: jsonschema, functools32 11:51:24 INFO - Running setup.py install for functools32 11:51:24 INFO - warning: no files found matching '*.txt' 11:51:24 INFO - no previously-included directories found matching 'build' 11:51:24 INFO - no previously-included directories found matching 'dist' 11:51:24 INFO - no previously-included directories found matching '.git*' 11:51:24 INFO - Successfully installed jsonschema functools32 11:51:24 INFO - Cleaning up... 11:51:24 INFO - Return code: 0 11:51:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:51:24 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')]} 11:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:24 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')]} 11:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:24 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 0x7f09cf249f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a87160>, '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 0x1a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a884f0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', '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 11:51:24 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 11:51:24 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 11:51:24 INFO - Using env: {'DISPLAY': ':0', 11:51:24 INFO - 'HOME': '/home/cltbld', 11:51:24 INFO - 'LANG': 'en_US.UTF-8', 11:51:24 INFO - 'LANGUAGE': 'en_US:en', 11:51:24 INFO - 'LOGNAME': 'cltbld', 11:51:24 INFO - 'MAIL': '/var/mail/cltbld', 11:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:24 INFO - 'MOZ_NO_REMOTE': '1', 11:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:24 INFO - 'NO_EM_RESTART': '1', 11:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:24 INFO - 'PWD': '/builds/slave/test', 11:51:24 INFO - 'SHELL': '/bin/bash', 11:51:24 INFO - 'SHLVL': '1', 11:51:24 INFO - 'TERM': 'linux', 11:51:24 INFO - 'TMOUT': '86400', 11:51:24 INFO - 'USER': 'cltbld', 11:51:24 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', 11:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:24 INFO - '_': '/tools/buildbot/bin/python'} 11:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:24 INFO - Downloading/unpacking flake8 11:51:24 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 11:51:24 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 11:51:24 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 11:51:24 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 11:51:24 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 11:51:24 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 11:51:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:51:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:51:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:51:27 INFO - no previously-included directories found matching 'docs/_build' 11:51:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:51:27 INFO - Running setup.py install for pep8 11:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:51:27 INFO - no previously-included directories found matching 'docs/_build' 11:51:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:51:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:51:27 INFO - Cleaning up... 11:51:27 INFO - Return code: 0 11:51:27 INFO - Running post-action listener: _resource_record_post_action 11:51:27 INFO - Running post-action listener: _start_resource_monitoring 11:51:27 INFO - Starting resource monitoring. 11:51:27 INFO - ##### 11:51:27 INFO - ##### Running install step. 11:51:27 INFO - ##### 11:51:27 INFO - Running pre-action listener: _resource_record_pre_action 11:51:27 INFO - Running main action method: install 11:51:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:28 INFO - Reading from file tmpfile_stdout 11:51:28 INFO - Detecting whether we're running mozinstall >=1.0... 11:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:51:28 INFO - Reading from file tmpfile_stdout 11:51:28 INFO - Output received: 11:51:28 INFO - Usage: mozinstall [options] installer 11:51:28 INFO - Options: 11:51:28 INFO - -h, --help show this help message and exit 11:51:28 INFO - -d DEST, --destination=DEST 11:51:28 INFO - Directory to install application into. [default: 11:51:28 INFO - "/builds/slave/test"] 11:51:28 INFO - --app=APP Application being installed. [default: firefox] 11:51:28 INFO - mkdir: /builds/slave/test/build/application 11:51:28 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'] 11:51:28 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 11:51:40 INFO - Reading from file tmpfile_stdout 11:51:40 INFO - Output received: 11:51:40 INFO - /builds/slave/test/build/application/firefox/firefox 11:51:40 INFO - Running post-action listener: _resource_record_post_action 11:51:40 INFO - ##### 11:51:40 INFO - ##### Running run-tests step. 11:51:40 INFO - ##### 11:51:40 INFO - Running pre-action listener: _resource_record_pre_action 11:51:40 INFO - Running main action method: run_tests 11:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:51:40 INFO - Python 2.7.3 11:51:40 INFO - Return code: 0 11:51:40 INFO - grabbing minidump binary from tooltool 11:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:40 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 0x1a87160>, '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 0x1a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a884f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:51:40 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 11:51:40 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 11:51:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:51:40 INFO - Return code: 0 11:51:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:51:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:51:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:51:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:51:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:51:41 INFO - Return code: 0 11:51:41 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/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 11:51:41 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/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 11:51:41 INFO - Using env: {'DISPLAY': ':0', 11:51:41 INFO - 'HOME': '/home/cltbld', 11:51:41 INFO - 'LANG': 'en_US.UTF-8', 11:51:41 INFO - 'LANGUAGE': 'en_US:en', 11:51:41 INFO - 'LOGNAME': 'cltbld', 11:51:41 INFO - 'MAIL': '/var/mail/cltbld', 11:51:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:51:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:41 INFO - 'MOZ_NO_REMOTE': '1', 11:51:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:41 INFO - 'NO_EM_RESTART': '1', 11:51:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:41 INFO - 'PWD': '/builds/slave/test', 11:51:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:51:41 INFO - 'SHELL': '/bin/bash', 11:51:41 INFO - 'SHLVL': '1', 11:51:41 INFO - 'TERM': 'linux', 11:51:41 INFO - 'TMOUT': '86400', 11:51:41 INFO - 'USER': 'cltbld', 11:51:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567', 11:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:41 INFO - '_': '/tools/buildbot/bin/python'} 11:51:41 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/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 11:51:42 INFO - mozversion application_buildid: 20160506063418 11:51:42 INFO - mozversion application_changeset: f485ca11d5d597330094223dd9cc9dfa035f7ab3 11:51:42 INFO - mozversion application_display_name: Firefox 11:51:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:51:42 INFO - mozversion application_name: Firefox 11:51:42 INFO - mozversion application_remotingname: firefox 11:51:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:51:42 INFO - mozversion application_vendor: Mozilla 11:51:42 INFO - mozversion application_version: 47.0 11:51:42 INFO - mozversion platform_buildid: 20160506063418 11:51:42 INFO - mozversion platform_changeset: f485ca11d5d597330094223dd9cc9dfa035f7ab3 11:51:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:51:42 INFO - mozversion platform_version: 47.0 11:51:42 INFO - using testdate: 1462560702 11:51:42 INFO - actual date: 1462560702 11:51:42 INFO - starting webserver on 'localhost:34610' 11:51:42 INFO - SUITE-START | Running 2 tests 11:51:42 INFO - TEST-START | dromaeo_css 11:51:42 INFO - operating with platform_type : linux_ 11:51:42 INFO - Initialising browser for dromaeo_css test... 11:51:42 INFO - TEST-INFO | started process 10912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvs3cln/profile http://localhost:34610/getInfo.html) 11:51:46 INFO - PROCESS | 10912 | __metrics Screen width/height:1600/1200 11:51:46 INFO - PROCESS | 10912 | colorDepth:24 11:51:46 INFO - PROCESS | 10912 | Browser inner width/height: 1024/697 11:51:46 INFO - PROCESS | 10912 | __metrics 11:51:47 INFO - PROCESS | 10912 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:51:47 INFO - TEST-INFO | 10912: exit 0 11:51:47 INFO - Browser initialized. 11:51:47 INFO - Running cycle 1/1 for dromaeo_css test... 11:51:47 INFO - TEST-INFO | started process 11001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvs3cln/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:59 INFO - PROCESS | 11001 | RSS: Main: 139735040 11:51:59 INFO - PROCESS | 11001 | 11:52:50 INFO - PROCESS | 11001 | 1462560770742 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] 11:54:58 INFO - PROCESS | 11001 | Cycle 1(1): loaded http://localhost:34610/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34610/tests/dromaeo/cssquery-ext.html) 11:54:59 INFO - PROCESS | 11001 | RSS: Main: 251936768 11:54:59 INFO - PROCESS | 11001 | 11:58:01 INFO - PROCESS | 11001 | Cycle 1(1): loaded http://localhost:34610/tests/dromaeo/cssquery-ext.html (next: http://localhost:34610/tests/dromaeo/cssquery-jquery.html) 11:58:02 INFO - PROCESS | 11001 | RSS: Main: 227418112 11:58:02 INFO - PROCESS | 11001 | 12:01:03 INFO - PROCESS | 11001 | Cycle 1(1): loaded http://localhost:34610/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34610/tests/dromaeo/cssquery-mootools.html) 12:01:04 INFO - PROCESS | 11001 | RSS: Main: 237248512 12:01:04 INFO - PROCESS | 11001 | 12:04:06 INFO - PROCESS | 11001 | Cycle 1(1): loaded http://localhost:34610/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34610/tests/dromaeo/cssquery-prototype.html) 12:04:06 INFO - PROCESS | 11001 | RSS: Main: 208855040 12:04:06 INFO - PROCESS | 11001 | 12:07:09 INFO - PROCESS | 11001 | Cycle 1(1): loaded http://localhost:34610/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34610/tests/dromaeo/cssquery-yui.html) 12:07:09 INFO - PROCESS | 11001 | RSS: Main: 198483968 12:07:09 INFO - PROCESS | 11001 | 12:10:12 INFO - PROCESS | 11001 | Cycle 1(1): loaded http://localhost:34610/tests/dromaeo/cssquery-yui.html (next: http://localhost:34610/tests/dromaeo/cssquery-dojo.html) 12:10:12 INFO - PROCESS | 11001 | RSS: Main: 253595648 12:10:12 INFO - PROCESS | 11001 | 12:10:12 INFO - PROCESS | 11001 | __start_tp_report 12:10:12 INFO - PROCESS | 11001 | _x_x_mozilla_page_load 12:10:12 INFO - PROCESS | 11001 | _x_x_mozilla_page_load_details 12:10:12 INFO - PROCESS | 11001 | |i|pagename|runs| 12:10:12 INFO - PROCESS | 11001 | |0;dojo.html;3285.3593549257894;3321.7342612590996;3340.7661463697536;3342.7492938029654;3366.764326497145;5378.193271009346;5386.48828361306;5392.379876314225;5404.486573775494;5424.159255315428;5375.381831089426;5393.6763794172375;5403.027455058088;5403.891922161554;5406.54044406226;4871.975640121795;4898.966928724575;4940.308356830046;4960.379952505937;5003.974980125113;4887.8778030549165;4907.5583197512215;4964.304997300381;4972.229304457815;4973.751312434382;4936.580390666798;5014.924776128361;5060.822871199509;5098.464661210575;5108.514691104339;5018;5023.0707319145895;5045.520675535819;5046.142155833517;5070.163423035213;4562.064776720765;4882.41411030675;4911.435184953741;4926.729029903354;4967.453580106186;5243.659162154486;5245.1869960155855;5246.213068039787;5257.894842103136;5299.258103865462;5715.028445164332;5773.451522105393;5824.941750582525;5845.064789633639;5853.0635098384055;5761.971190144064;5778.335491418498;5784.219130417382;5786.594938354317;5843.094320380305;5477.917831232495;5517.917231241495;5520.696361700065;5520.834374968757;5537.224788529609;5871.2073870027;5989.101634754735;6004.849878753066;6023.66869822164;6024.457798798129;5787.450192231731;5789.421057894261;5793.362730099686;5803.361630220672;5817.301923769175;5861.9706901465215;5863.208466857005;5865.853353666193;5869.941300587025;5876.647401155944;5637.351704554028;5717.599768016199;5810.360860305363;5829.912551311733;5851.356350801409;5788.27646544182;5794.478496935296;5796.710164491758;5803.419658034163;5803.8549036274435;4382.517923028464;4426.513083560806;4429.468463784302;4432.800523976429;4448.532904045029;3949.664278536299;3969.206158768258;3981.22366138606;4039.293123703399;4079.63283304504;5484.588655850827;5495.2856128703015;5503.7798488060025;5504.862378440491;5506.752196151183;5824.271966004249;5838.883222335529;5841;5843.328017278068;5869.911951320733;5354.41101478837;5509.173623956439;5589.469000444951;5621.297337832771;5643.351014633287;5006.424261210008;5007.899842003212;5024.949750502448;5026.723530205873;5059.544640982329;5884.941150588525;6032.065029920369;6049.516038716892;6050.213472248667;6050.878982420415;5765.740541675718;5815.127730840408;5844.3571207168025;5851.180834683233;5853.414658534283;6013.9097913532205;6052.90920636182;6053.243344581927;6055.5458340623745;6059.3334733178435;5697.971510142588;5771.7402716877;5834.591578589458;5841.737121829443;5861.325947515919;5871.94128058714;5901.2033375495475;5906.557008224487;5923.229980102731;5937.970310148422;5724.169995350568;5749.396313387034;5756.740946657326;5767.336756273083;5767.452092051249;5590.86022849432;5690.886182276248;5717.914231286617;5759.625624334405;5815.534757219328;5648.124540696199;5662.094064949588;5666.829995100154;5669.149627555899;5676.602637815313;5763.4812866842185;5770.480656740913;5792.044312688359;5807.94192058074;5809.796657116981;5461.317335333083;5617.241672374341;5663.292088488939;5690.857728556819;5700.315962084411 12:10:12 INFO - PROCESS | 11001 | |1;ext.html;543.9537639300662;563.4281204577353;569.5443645083932;581.1486172756913;581.7062383496334;38429;39135.80432097843;39178.21643567127;39235.607643923555;39264.607353926454;44800;45332.77333613327;45364.77317613416;45404.545954540445;45437;9024.413413128159;9233.769155771126;9235.492047937361;9245.121713437245;9246.722598322027;9098.090190980882;9277.628894844198;9279.118483744034;9283.721488355326;9285;9203.907960920405;9304.302177336693;9315.347925645208;9319.021502742216;9325;9183.58673859678;9265.629374825;9267.165955064009;9276.16514513697;9282.767930801716;8917.108289171096;9178.265738740885;9193.678221262224;9195.770105747342;9201.079892010745;41644;42029.57970420287;42106.15787684229;42235.7888210557;42247.577524224675;3590.35373632746;3641.6722494975315;3693.316736403747;4243.724157929724;4295.377170310318;30396.848015760002;30681.232969175948;32819.83590082058;33458.6654133458;33553;4199.9790001050105;4236.703430759848;4244.08752118293;4264.701470897038;4276.2516559601945;294344;295628;295730;296027;296286;45646.543534564895;62288.688556557834;62683;62817.68591157015;62858.371416286165;43985;44263;44280.3357949631;44344;44426.77786611046;15088;15365.154916479702;15412.922935385252;15440.768388474182;15445.922770386076;10972.561097556169;11105.333679979227;11108.722281943015;11110.277831940897;11119.833202501968;15231.771523427158;15358.769618455508;15722.764158537631;15769.29038193284;15782;5889.911651325234;5947.167396564484;6031.60794548353;6108.816735497942;6160.630362178284;1067.7223921780394;1083.5774048121239;1090.5223422262877;1109.6116359274351;1230.8276841242234;30091.404229121188;30211.546826797614;30500.38999220003;30628.234294142825;30660.38679226403;1132.2753437799815;1139.632386298486;1167.5563285951284;1172.1209093180114;1175.3594291111365;15534.922325388527;15766.9211653941;15783.131927744083;15803.288852001457;16277.348906043626;331637;333992;335945;336216;336624;56151.438485615436;56482.7175864118;56690.716546417;56975;57064.85870282654;1362.5707902010636;1390.2075816784336;1449.8985071044926;1455.3596417576232;1475.2476237119147;27199.04803331953;27693.30766730848;28572.285692857844;28804.279893002844;29730.405391892473;44237.77881110574;44699;44747.32879006752;44751.552484476044;44785;202774;213964;217001;217399;219241;30306.545401819432;31009.534856977614;33424;34411.31177376388;35105;41861.1627767449;41874.162516750104;41910.16179676451;42542.361864572675;42558.361624576275;33400.49899251562;36650;36682.44976325304;37677.24645507129;38136.427953581275;36860.81569592135;37362.25275494529;37468.063298416666;37499.06252343713;37881.81059094797;36560;36944.63055369412;40861.795691021354;41018.1796364077;41421;33731.15672108217;34104;34365.14087147841;34403.96788096361;34536.309273814884;26976.325591859575;27083.86458067697;27184.864075679496;27204.319892002066;27314.863425682743 12:10:12 INFO - PROCESS | 11001 | |2;jquery.html;373.7682636765204;381.3764495050592;386.66939766499627;395.7585872617703;396.0336778261043;17317.393891213793;18312.633747325046;18860.905695471505;18866.811331886678;18923.716144257847;11764.411779411039;12180.451879665414;12190.207636503621;12194.878051219484;12197;5193.922091168635;5313.57544035636;5638.097904335307;5786.68173250471;5793.333766616851;5689.6017278790505;5758.913616295759;5759.337676167232;5762.1068734346245;5789.797357092502;5338.706371149585;5556.722163891809;5562.16567514872;5726.599138060337;5741.167530708045;5502.697351645658;5504.834854954338;5509.669419834822;5542.8337149885365;5830.3586605473365;5711.228984087178;5734.541236701054;5735.483806457439;5737.139429085671;5738.368779434259;12590.81113783294;12784.488620455171;12993.935030324883;13164.6708832279;13173.341332933314;2242.327301809467;2269.4439862233858;2311.3874823171873;2545.3000424883307;2672.7327267273313;9134.634614615408;9392.48341341226;9980.151687106532;10931.890681093246;13785.035047546677;1940.1075505267595;1957.0508303472805;1963.1950900130878;1969.3008981811538;1988.9403317900485;51596;61104.38895611031;63031;64917.3508264916;66856;9555.761105972406;10105.797884042426;10219.48902554884;10475.895241047492;10634.09610183143;13726.725465490634;14045.78931316031;14409.85590144106;14467.638309042359;14482.855171448362;7478.85042299151;7647.923520764833;7676.19399963007;7795.649195786204;7818.452708310364;7254.274572542809;7464.664090115958;7467.813304667427;7558.58427786477;7570.205128461433;4504.617107545895;4517.096580683877;4551.749653769075;4591.747453890068;4607.124646317189;1892.4606487151095;1927.9325223617107;1946.9610607787765;1967.9409617711492;2016.6874134509173;975.8097171051577;992.5434300221834;999.1557134221571;1000.3547711725896;1063.9520072728355;17406.39077632302;17548;17656.735148972777;17759.733603995952;17969.19138638738;964.6430820596424;977.2279898879948;1007.315025782475;1022.943738094412;1063.7659714862718;9911.908484081578;10116.797664046826;10278.22913281507;10361.740956475998;10443.373397596017;418071;422440;426989;428302;435620;72476.27523724695;74816.62591687006;75776;76380;77227;988.6539711101057;988.7132731507926;997.7505623594102;1012.6202673997251;1016.5273147986222;14720.852791471949;14874.256287185814;14926.477573284883;15181.468648597687;15232.535590152409;33747.81882634096;34043.31913361768;34279.65720342765;34381.31237375289;34695.13262168365;46933.53066469292;48019.75990120027;48650.756746216044;48662.756686216344;48894.75552622214;8319.292860106958;8369.83260334802;8385.496870187808;8469.57652117404;8578.528180950108;11656.88343116558;12687;12900.935495322463;13283.269420181983;13325.466981320638;11386.316820990767;11421.486033128363;11748.823767643664;11766.470508827295;11847.703807404883;11400.828987565359;11469.426528673366;11650.184487086162;11784.175107742376;11898.881011189776;11427.828582571434;11552.595659152226;11598.478068487108;11812.055035597303;11929;8209.384296177692;8247.463914845515;8428.873566896624;8492.702755403778;8494.74515764528;10736.194785390971;11177.105831533621;11210.103191744804;11600.49193604826;11680.591179308683 12:10:12 INFO - PROCESS | 11001 | |3;mootools.html;1430.9141451512903;1525.938962441502;1542.73773458512;1735.4273089880342;1850.518865095075;7503.13713922899;7922.524648521093;8052.154523775;8054.798630034252;8064.71773487928;8195.795105122375;8388.66445342187;8391.076981532027;8395.664173433055;8396.45423047503;2367.7987371073436;2387.892544835478;2393.5811233034237;2394.365493144318;2394.748551402095;2362.7637236276405;2375.798057165134;2437.549053425113;2443.144899285254;2463.1625247415873;2403.9158629447975;2404.663347131403;2414.082648593541;2436.4030812450974;2437.9634305485433;2391.414103544634;2400.6879105716234;2401.9519609607796;2419.2863105383776;2471.209213051824;2365.757977062039;2410.3974006498374;2418.5646583614944;2421.237310247284;2423.648570957201;8247.670093196264;8541.35939804511;8565.957170214171;8566.186212309884;8573.442726222776;5097.184450487941;5208.609354298443;5215.739213039371;5218.895622087575;5218.947810521884;3251.0246925922365;3255.3814775192636;3277.7869438486423;3290.7367410607094;3336.199312165087;1030.006044167382;2018.3137733170793;2041.7856125106798;2105.3683894831643;2110.1137522240697;11383;11461.140414469031;11477.827832582518;11489.597864074718;11490.080793536581;4359.542248063907;4509.842155524607;4540.455145382509;4594.310853371954;4601.631869450436;9420.576074076684;9470.810583788423;9471.810563788824;9473.100055494717;9476.478793666414;5130.358705161855;5156.097682905476;5164.328637277205;5169.353830771153;5173.456787037382;4132.504099508018;4200.810963506649;4248.957510424856;4411.823527058946;4768.1417344878255;3859.1124041470057;3931.8427262909736;3934.0361611405388;3942.8817135485983;3982.5021872265966;1265.8101284807353;1267.461328935199;1274.1654216488214;1279.635303938373;1281.090425797694;1440.0495672855866;1456.9490067847576;1464.9414023439156;1479.9334029968677;1487.732208202534;7937.642806073625;8067.435279530494;8141.79645508867;8167.060788009336;8170.509769413854;514.6371807875514;526.6603041038509;531.1183435497056;537.0815904802831;537.6639600249844;6184.134221208944;6210.72051757672;6237.844053898689;6243.094751261133;6295.622262664255;9892.703218903445;10389;10392.220583456272;10406.947965260126;10415.375077495375;9499.762505937408;10159.695209143738;10224.335418197794;10256.641017564349;10261.640842570474;7592.620368981528;7732.922670773332;7771.727989520453;7807.297343239135;7808.609569521501;7726.1501234863;7835.882461763192;7864.4888082274465;7931.325837303893;7947.403944704055;8709.956450217709;8860.64557417696;8946.239569636653;9165.083491650781;9173.082691730773;8997.235235004837;9114.817703646022;9121.133492318218;9234.584443699916;9247.0752924707;6727.058211850247;6961.756338528127;7155.749548765768;7391.889121663072;7485.588292643739;8027.879581806161;8039.879401809095;8054.919450805417;8122.959385203036;8129.634166462405;7139.32176443237;7191.892121618075;7234.493585448968;7249.637518124178;7487.47587668858;7074.752383666547;7159;7160.283971602798;7264;7276.781696549112;7619.809504762204;7740.148583655906;7752.496087754278;7758.4181186410115;7765.572893490912;6950.721971121301;6952.304769523007;6985.895211571932;7002.929970700227;7017.122859642544;6922.8961565577565;7121.252268511939;7143.071400717873;7145.1783044948415;7156.427485801019 12:10:12 INFO - PROCESS | 11001 | |4;prototype.html;329.18855022369854;331.8423748719358;336.25016213843145;337.4634331413054;339.67900334184196;5970.910436343458;5972.492338151263;6014.127951447038;6028.939710602893;6038.245219347582;5970.522358211343;5972.223610930584;5985.8204253872345;5989.790357337494;5996.220491336131;4468.731876087429;4552.9089418211615;4629.4444666639965;4657.906841863178;4703.318018887259;4672.3692301539195;4688.156131896258;4692.835750748724;4694.2723877799;4701.60036396905;4636.814527418916;4639.884002899921;4648.837290694826;4652.116097941397;4661.114388266218;4443.311286750559;4515.05183911379;4566;4585.151746926796;4603.746793926332;4043.6158564936286;4051.0682543014977;4059.944414452234;4066.8169932353117;4069.3285607874664;5703.144528320744;5736.340320863071;5746.885062298772;5748.655080695172;5756.856078598027;5399;5399.19012148177;5408.026555220059;5410.513053825135;5417.891642167135;6341.302456729756;6346.936530634727;6349.52378571609;6357.904631430532;6363.395477429637;4255.680823938217;4358.825646974117;4376.146651402978;4404.273294906337;4532.388127602764;6563.606183628997;6610.173728283965;6611.50413718973;6626.801195964081;6628.966855165741;4457.888552786207;4458.219811532968;4465.37484752135;4467;4473.977630111894;4515.954840451619;4522.4346956630425;4522.909541809146;4522.954770452319;4523.5024147343765;5265.104932161542;5269.815556455505;5273.683578985273;5281.234221038005;5285.2600635911;6189.81430557084;6336.239651241788;6412.198475190601;6429.324920883333;6430;1574.8818838587151;1586.2623879895673;1597.0258142533046;1597.0258142533278;1604.0455928722392;995.8058178655093;1035.1098055672117;1038.4651904269156;1041.1930753665818;1063.1388575254068;6049.062395328731;6066.817995460143;6069.484093852072;6070.6357618543025;6076.817695469143;6414.069959855795;6484.740610375532;6526;6528.771492997817;6544.836379090466;6140.600860944024;6145.692715364214;6148.077788331786;6152.969235153795;6156;3426.674465925733;3487.4245749451566;3514.4728290756593;3516.5955915069585;3518.1908161122574;6327.968360158262;6487.772927947499;6660.367265109807;6732.259451460335;6734.595924244561;6614.570052946543;6665.166854143232;6690.966545167243;6693.899591506131;6876.277990810993;6887.483438742114;6887.758928437481;6932.272111428228;6933.618650974245;6969.128858892638;6651.102101216274;6664.83337916556;6721.294264102199;6736.66316684154;6739.73041078371;6566.540342176002;6572.309907459839;6583.967080164569;6586.407223349922;6587;6710.228323742832;6817.795466136024;6847.109875716125;6858.862822743417;6860.965695171692;4525.547445255448;4547.909041819211;4562.5665561771575;4568.840090596813;4572.88567785808;6640.203175618956;6648.434883034996;6650.235222949423;6659;6664.866702665822;6458;6469.967650161719;6475.352464753675;6476.773312934025;6479.5788273762055;6461.547691661539;6467.708953097028;6468.838279043061;6481.157449531531;6485.578437401554;6112.938870611415;6243.750249989949;6259.374062593704;6306.747730090745;6355.173827402408;6446.5165112615805;6478.643674597943;6479.967600161969;6495.317991611002;6500.057491663777;6338.619682819046;6345.302016778059;6346.111544383883;6359.046143078575;6361.395667411589 12:10:12 INFO - PROCESS | 11001 | |5;yui.html;780.7267456390264;805.5529181304373;871.1201686296839;901.48164805237;909.8726178335032;14509.92745036276;14537.709245815078;14632.268386580668;14646.048006879559;14681;13791.448342066305;13896.096753711001;13941;14014.299285035733;14022.509212177576;901.7790641292893;912.703371404293;919.9264058875274;920.1672486399785;920.2545937790378;908.0919080919081;910.658503061352;912.4114945859916;913.5067063785581;913.5569248914271;964.5852283518085;966.8936416994125;969.5103972493916;969.7236287658019;969.883613966325;954.9140577348037;960.1214888377126;960.4141473701037;961.053362438005;962.2494454325567;712.2130046298869;712.565335145566;712.5795780489536;712.7362875735959;713.9178994415656;13781.448742050306;13811.240381778998;13811.930940345335;13816;13845.376958036912;12510.37448127599;12538.122331436804;12546.372681365896;12649.304288264142;12864.678383040406;10594.152467802558;10810.621628242974;10911.181661375429;11021.118310535137;11082.501287442085;3734.6638802507905;3866.961330386688;3868.9226215475533;3871.9419208711893;3891.5913829047827;50536.241956370315;50663;50769;50942.74528627333;51759.48240517584;9740.464274464972;9827.950860245795;9938.751531211778;9958.900410995942;10021.34861234032;18462.44612661622;18544.907275463538;18564.071796410124;18589.81410185908;18636.72044919327;7875.173106823816;8095.676172953016;8317.085120636724;8361.623726932181;8381.28759055475;4566.4063671723125;4758.3100450434495;4799.136155491975;4833.154198015403;4881.316615673809;3329.93340133196;3364.1925937775245;3372.1401042733946;3373.6795004474534;3373.8481768320485;583.3175185033521;609.2719200555382;611.3794498583941;612.8069658057698;625.7684656677059;644.9193850768654;678.6810199206365;678.759040540601;719.4100837313352;724.4457989637931;8127.918720812834;8280;8339.666413343519;8550.871736923951;8632.223099920911;664.4020381656451;670.1321788284183;674.153936809311;709.0817391478048;729.5221629832469;3985.2826491231276;4143.937840932388;4147.52303485103;4175.89621844985;4312.913741725148;60677.39322606717;60948.390516094274;60950.695246523486;62124;62137.68931155315;43062.78468607637;53597.1960420594;54277.1858422124;54460.45539544554;54704.45295546993;46147.76926115348;46260;50097.74951125221;50595.49404505908;51307;8612.526311052952;8652.610632521426;8661.8700719488;8682.43564168327;8877.422967507091;36137.0965725859;36254.27491450103;36871.262574747816;37718.62281377151;38462.42306365351;47235.76382118068;47679;48013.759931201515;49115;49880.750596246784;11063.50214240345;11098.778024439627;11357.204995650225;12075.456604452645;12508.937455312665;11122.3326600401;11187.272827266203;11285.548578056785;11967.341796201292;12127.151099422956;11119.44402779874;12513.937430313154;12703;12866.871331286942;13036.543720969721;12058.75882482363;12096.153269271419;12691.365431728193;12763.170393924365;12978.870211297766;11231.746917146416;11505.884941150816;11728.179027467995;11745.706357341134;11950.820737689115;9689.176420004378;10042.447665378182;10506.789864202521;10634.255602108087;10740.624078157227;9925.654434660792;10325.277230594087;10375.4027524538;10436.321639093434;10510.159187265153 12:10:12 INFO - PROCESS | 11001 | __end_tp_report 12:10:12 INFO - PROCESS | 11001 | __start_cc_report 12:10:12 INFO - PROCESS | 11001 | _x_x_mozilla_cycle_collect,888 12:10:12 INFO - PROCESS | 11001 | __end_cc_report 12:10:12 INFO - PROCESS | 11001 | __startTimestamp1462561812311__endTimestamp 12:10:12 INFO - PROCESS | 11001 | 12:10:12 INFO - PROCESS | 11001 | ------- Summary: start ------- 12:10:12 INFO - PROCESS | 11001 | Number of tests: 6 12:10:12 INFO - PROCESS | 11001 | 12:10:12 INFO - PROCESS | 11001 | [#0] dojo.html Cycles:165 Average:5424.25 Median:5666.83 stddev:601.01 (10.6%) stddev-sans-first:578.96 12:10:12 INFO - PROCESS | 11001 | Values: 3285.4 3321.7 3340.8 3342.7 3366.8 5378.2 5386.5 5392.4 5404.5 5424.2 5375.4 5393.7 5403.0 5403.9 5406.5 4872.0 4899.0 4940.3 4960.4 5004.0 4887.9 4907.6 4964.3 4972.2 4973.8 4936.6 5014.9 5060.8 5098.5 5108.5 5018.0 5023.1 5045.5 5046.1 5070.2 4562.1 4882.4 4911.4 4926.7 4967.5 5243.7 5245.2 5246.2 5257.9 5299.3 5715.0 5773.5 5824.9 5845.1 5853.1 5762.0 5778.3 5784.2 5786.6 5843.1 5477.9 5517.9 5520.7 5520.8 5537.2 5871.2 5989.1 6004.8 6023.7 6024.5 5787.5 5789.4 5793.4 5803.4 5817.3 5862.0 5863.2 5865.9 5869.9 5876.6 5637.4 5717.6 5810.4 5829.9 5851.4 5788.3 5794.5 5796.7 5803.4 5803.9 4382.5 4426.5 4429.5 4432.8 4448.5 3949.7 3969.2 3981.2 4039.3 4079.6 5484.6 5495.3 5503.8 5504.9 5506.8 5824.3 5838.9 5841.0 5843.3 5869.9 5354.4 5509.2 5589.5 5621.3 5643.4 5006.4 5007.9 5024.9 5026.7 5059.5 5884.9 6032.1 6049.5 6050.2 6050.9 5765.7 5815.1 5844.4 5851.2 5853.4 6013.9 6052.9 6053.2 6055.5 6059.3 5698.0 5771.7 5834.6 5841.7 5861.3 5871.9 5901.2 5906.6 5923.2 5938.0 5724.2 5749.4 5756.7 5767.3 5767.5 5590.9 5690.9 5717.9 5759.6 5815.5 5648.1 5662.1 5666.8 5669.1 5676.6 5763.5 5770.5 5792.0 5807.9 5809.8 5461.3 5617.2 5663.3 5690.9 5700.3 12:10:12 INFO - PROCESS | 11001 | 12:10:12 INFO - PROCESS | 11001 | [#1] ext.html Cycles:180 Average:45523.16 Median:37483.56 stddev:74749.96 (199.4%) stddev-sans-first:74883.36 12:10:12 INFO - PROCESS | 11001 | Values: 544.0 563.4 569.5 581.1 581.7 38429.0 39135.8 39178.2 39235.6 39264.6 44800.0 45332.8 45364.8 45404.5 45437.0 9024.4 9233.8 9235.5 9245.1 9246.7 9098.1 9277.6 9279.1 9283.7 9285.0 9203.9 9304.3 9315.3 9319.0 9325.0 9183.6 9265.6 9267.2 9276.2 9282.8 8917.1 9178.3 9193.7 9195.8 9201.1 41644.0 42029.6 42106.2 42235.8 42247.6 3590.4 3641.7 3693.3 4243.7 4295.4 30396.8 30681.2 32819.8 33458.7 33553.0 4200.0 4236.7 4244.1 4264.7 4276.3 294344.0 295628.0 295730.0 296027.0 296286.0 45646.5 62288.7 62683.0 62817.7 62858.4 43985.0 44263.0 44280.3 44344.0 44426.8 15088.0 15365.2 15412.9 15440.8 15445.9 10972.6 11105.3 11108.7 11110.3 11119.8 15231.8 15358.8 15722.8 15769.3 15782.0 5889.9 5947.2 6031.6 6108.8 6160.6 1067.7 1083.6 1090.5 1109.6 1230.8 30091.4 30211.5 30500.4 30628.2 30660.4 1132.3 1139.6 1167.6 1172.1 1175.4 15534.9 15766.9 15783.1 15803.3 16277.3 331637.0 333992.0 335945.0 336216.0 336624.0 56151.4 56482.7 56690.7 56975.0 57064.9 1362.6 1390.2 1449.9 1455.4 1475.2 27199.0 27693.3 28572.3 28804.3 29730.4 44237.8 44699.0 44747.3 44751.6 44785.0 202774.0 213964.0 217001.0 217399.0 219241.0 30306.5 31009.5 33424.0 34411.3 35105.0 41861.2 41874.2 41910.2 42542.4 42558.4 33400.5 36650.0 36682.4 37677.2 38136.4 36860.8 37362.3 37468.1 37499.1 37881.8 36560.0 36944.6 40861.8 41018.2 41421.0 33731.2 34104.0 34365.1 34404.0 34536.3 26976.3 27083.9 27184.9 27204.3 27314.9 12:10:12 INFO - PROCESS | 11001 | 12:10:12 INFO - PROCESS | 11001 | [#2] jquery.html Cycles:180 Average:25012.17 Median:34538.22 stddev:69933.73 (202.5%) stddev-sans-first:70105.44 12:10:12 INFO - PROCESS | 11001 | Values: 373.8 381.4 386.7 395.8 396.0 17317.4 18312.6 18860.9 18866.8 18923.7 11764.4 12180.5 12190.2 12194.9 12197.0 5193.9 5313.6 5638.1 5786.7 5793.3 5689.6 5758.9 5759.3 5762.1 5789.8 5338.7 5556.7 5562.2 5726.6 5741.2 5502.7 5504.8 5509.7 5542.8 5830.4 5711.2 5734.5 5735.5 5737.1 5738.4 12590.8 12784.5 12993.9 13164.7 13173.3 2242.3 2269.4 2311.4 2545.3 2672.7 9134.6 9392.5 9980.2 10931.9 13785.0 1940.1 1957.1 1963.2 1969.3 1988.9 51596.0 61104.4 63031.0 64917.4 66856.0 9555.8 10105.8 10219.5 10475.9 10634.1 13726.7 14045.8 14409.9 14467.6 14482.9 7478.9 7647.9 7676.2 7795.6 7818.5 7254.3 7464.7 7467.8 7558.6 7570.2 4504.6 4517.1 4551.7 4591.7 4607.1 1892.5 1927.9 1947.0 1967.9 2016.7 975.8 992.5 999.2 1000.4 1064.0 17406.4 17548.0 17656.7 17759.7 17969.2 964.6 977.2 1007.3 1022.9 1063.8 9911.9 10116.8 10278.2 10361.7 10443.4 418071.0 422440.0 426989.0 428302.0 435620.0 72476.3 74816.6 75776.0 76380.0 77227.0 988.7 988.7 997.8 1012.6 1016.5 14720.9 14874.3 14926.5 15181.5 15232.5 33747.8 34043.3 34279.7 34381.3 34695.1 46933.5 48019.8 48650.8 48662.8 48894.8 8319.3 8369.8 8385.5 8469.6 8578.5 11656.9 12687.0 12900.9 13283.3 13325.5 11386.3 11421.5 11748.8 11766.5 11847.7 11400.8 11469.4 11650.2 11784.2 11898.9 11427.8 11552.6 11598.5 11812.1 11929.0 8209.4 8247.5 8428.9 8492.7 8494.7 10736.2 11177.1 11210.1 11600.5 11680.6 12:10:12 INFO - PROCESS | 11001 | 12:10:12 INFO - PROCESS | 11001 | [#3] mootools.html Cycles:180 Average:5856.37 Median:534.10 stddev:3023.51 (566.1%) stddev-sans-first:3013.69 12:10:12 INFO - PROCESS | 11001 | Values: 1430.9 1525.9 1542.7 1735.4 1850.5 7503.1 7922.5 8052.2 8054.8 8064.7 8195.8 8388.7 8391.1 8395.7 8396.5 2367.8 2387.9 2393.6 2394.4 2394.7 2362.8 2375.8 2437.5 2443.1 2463.2 2403.9 2404.7 2414.1 2436.4 2438.0 2391.4 2400.7 2402.0 2419.3 2471.2 2365.8 2410.4 2418.6 2421.2 2423.6 8247.7 8541.4 8566.0 8566.2 8573.4 5097.2 5208.6 5215.7 5218.9 5218.9 3251.0 3255.4 3277.8 3290.7 3336.2 1030.0 2018.3 2041.8 2105.4 2110.1 11383.0 11461.1 11477.8 11489.6 11490.1 4359.5 4509.8 4540.5 4594.3 4601.6 9420.6 9470.8 9471.8 9473.1 9476.5 5130.4 5156.1 5164.3 5169.4 5173.5 4132.5 4200.8 4249.0 4411.8 4768.1 3859.1 3931.8 3934.0 3942.9 3982.5 1265.8 1267.5 1274.2 1279.6 1281.1 1440.0 1456.9 1464.9 1479.9 1487.7 7937.6 8067.4 8141.8 8167.1 8170.5 514.6 526.7 531.1 537.1 537.7 6184.1 6210.7 6237.8 6243.1 6295.6 9892.7 10389.0 10392.2 10406.9 10415.4 9499.8 10159.7 10224.3 10256.6 10261.6 7592.6 7732.9 7771.7 7807.3 7808.6 7726.2 7835.9 7864.5 7931.3 7947.4 8710.0 8860.6 8946.2 9165.1 9173.1 8997.2 9114.8 9121.1 9234.6 9247.1 6727.1 6961.8 7155.7 7391.9 7485.6 8027.9 8039.9 8054.9 8123.0 8129.6 7139.3 7191.9 7234.5 7249.6 7487.5 7074.8 7159.0 7160.3 7264.0 7276.8 7619.8 7740.1 7752.5 7758.4 7765.6 6950.7 6952.3 6985.9 7002.9 7017.1 6922.9 7121.3 7143.1 7145.2 7156.4 12:10:12 INFO - PROCESS | 11001 | 12:10:12 INFO - PROCESS | 11001 | [#4] prototype.html Cycles:180 Average:5343.55 Median:6068.15 stddev:1620.36 (26.7%) stddev-sans-first:1580.59 12:10:12 INFO - PROCESS | 11001 | Values: 329.2 331.8 336.3 337.5 339.7 5970.9 5972.5 6014.1 6028.9 6038.2 5970.5 5972.2 5985.8 5989.8 5996.2 4468.7 4552.9 4629.4 4657.9 4703.3 4672.4 4688.2 4692.8 4694.3 4701.6 4636.8 4639.9 4648.8 4652.1 4661.1 4443.3 4515.1 4566.0 4585.2 4603.7 4043.6 4051.1 4059.9 4066.8 4069.3 5703.1 5736.3 5746.9 5748.7 5756.9 5399.0 5399.2 5408.0 5410.5 5417.9 6341.3 6346.9 6349.5 6357.9 6363.4 4255.7 4358.8 4376.1 4404.3 4532.4 6563.6 6610.2 6611.5 6626.8 6629.0 4457.9 4458.2 4465.4 4467.0 4474.0 4516.0 4522.4 4522.9 4523.0 4523.5 5265.1 5269.8 5273.7 5281.2 5285.3 6189.8 6336.2 6412.2 6429.3 6430.0 1574.9 1586.3 1597.0 1597.0 1604.0 995.8 1035.1 1038.5 1041.2 1063.1 6049.1 6066.8 6069.5 6070.6 6076.8 6414.1 6484.7 6526.0 6528.8 6544.8 6140.6 6145.7 6148.1 6153.0 6156.0 3426.7 3487.4 3514.5 3516.6 3518.2 6328.0 6487.8 6660.4 6732.3 6734.6 6614.6 6665.2 6691.0 6693.9 6876.3 6887.5 6887.8 6932.3 6933.6 6969.1 6651.1 6664.8 6721.3 6736.7 6739.7 6566.5 6572.3 6584.0 6586.4 6587.0 6710.2 6817.8 6847.1 6858.9 6861.0 4525.5 4547.9 4562.6 4568.8 4572.9 6640.2 6648.4 6650.2 6659.0 6664.9 6458.0 6470.0 6475.4 6476.8 6479.6 6461.5 6467.7 6468.8 6481.2 6485.6 6112.9 6243.8 6259.4 6306.7 6355.2 6446.5 6478.6 6480.0 6495.3 6500.1 6338.6 6345.3 6346.1 6359.0 6361.4 12:10:12 INFO - PROCESS | 11001 | 12:10:12 INFO - PROCESS | 11001 | [#5] yui.html Cycles:180 Average:14503.06 Median:26239.07 stddev:16847.29 (64.2%) stddev-sans-first:16863.04 12:10:12 INFO - PROCESS | 11001 | Values: 780.7 805.6 871.1 901.5 909.9 14509.9 14537.7 14632.3 14646.0 14681.0 13791.4 13896.1 13941.0 14014.3 14022.5 901.8 912.7 919.9 920.2 920.3 908.1 910.7 912.4 913.5 913.6 964.6 966.9 969.5 969.7 969.9 954.9 960.1 960.4 961.1 962.2 712.2 712.6 712.6 712.7 713.9 13781.4 13811.2 13811.9 13816.0 13845.4 12510.4 12538.1 12546.4 12649.3 12864.7 10594.2 10810.6 10911.2 11021.1 11082.5 3734.7 3867.0 3868.9 3871.9 3891.6 50536.2 50663.0 50769.0 50942.7 51759.5 9740.5 9828.0 9938.8 9958.9 10021.3 18462.4 18544.9 18564.1 18589.8 18636.7 7875.2 8095.7 8317.1 8361.6 8381.3 4566.4 4758.3 4799.1 4833.2 4881.3 3329.9 3364.2 3372.1 3373.7 3373.8 583.3 609.3 611.4 612.8 625.8 644.9 678.7 678.8 719.4 724.4 8127.9 8280.0 8339.7 8550.9 8632.2 664.4 670.1 674.2 709.1 729.5 3985.3 4143.9 4147.5 4175.9 4312.9 60677.4 60948.4 60950.7 62124.0 62137.7 43062.8 53597.2 54277.2 54460.5 54704.5 46147.8 46260.0 50097.7 50595.5 51307.0 8612.5 8652.6 8661.9 8682.4 8877.4 36137.1 36254.3 36871.3 37718.6 38462.4 47235.8 47679.0 48013.8 49115.0 49880.8 11063.5 11098.8 11357.2 12075.5 12508.9 11122.3 11187.3 11285.5 11967.3 12127.2 11119.4 12513.9 12703.0 12866.9 13036.5 12058.8 12096.2 12691.4 12763.2 12978.9 11231.7 11505.9 11728.2 11745.7 11950.8 9689.2 10042.4 10506.8 10634.3 10740.6 9925.7 10325.3 10375.4 10436.3 10510.2 12:10:12 INFO - PROCESS | 11001 | -------- Summary: end -------- 12:10:12 INFO - PROCESS | 11001 | 12:10:12 INFO - TEST-INFO | 11001: exit 0 12:10:12 INFO - TEST-OK | dromaeo_css | took 1110829ms 12:10:12 INFO - TEST-START | kraken 12:10:12 INFO - operating with platform_type : linux_ 12:10:12 INFO - Initialising browser for kraken test... 12:10:13 INFO - TEST-INFO | started process 11200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCsiUvN/profile http://localhost:34610/getInfo.html) 12:10:16 INFO - PROCESS | 11200 | __metrics Screen width/height:1600/1200 12:10:16 INFO - PROCESS | 11200 | colorDepth:24 12:10:16 INFO - PROCESS | 11200 | Browser inner width/height: 1024/697 12:10:16 INFO - PROCESS | 11200 | __metrics 12:10:17 INFO - PROCESS | 11200 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:10:18 INFO - TEST-INFO | 11200: exit 0 12:10:18 INFO - Browser initialized. 12:10:18 INFO - Running cycle 1/1 for kraken test... 12:10:18 INFO - TEST-INFO | started process 11294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCsiUvN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:10:30 INFO - PROCESS | 11294 | RSS: Main: 139890688 12:10:30 INFO - PROCESS | 11294 | 12:10:32 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34610/tests/kraken/driver.html?testName=audio-beat-detection) 12:10:33 INFO - PROCESS | 11294 | RSS: Main: 174432256 12:10:33 INFO - PROCESS | 11294 | 12:10:35 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34610/tests/kraken/driver.html?testName=audio-dft) 12:10:36 INFO - PROCESS | 11294 | RSS: Main: 173019136 12:10:36 INFO - PROCESS | 11294 | 12:10:39 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34610/tests/kraken/driver.html?testName=audio-fft) 12:10:39 INFO - PROCESS | 11294 | RSS: Main: 170647552 12:10:39 INFO - PROCESS | 11294 | 12:10:41 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34610/tests/kraken/driver.html?testName=audio-oscillator) 12:10:42 INFO - PROCESS | 11294 | RSS: Main: 171663360 12:10:42 INFO - PROCESS | 11294 | 12:10:44 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34610/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:10:45 INFO - PROCESS | 11294 | RSS: Main: 169570304 12:10:45 INFO - PROCESS | 11294 | 12:10:48 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34610/tests/kraken/driver.html?testName=imaging-darkroom) 12:10:48 INFO - PROCESS | 11294 | RSS: Main: 168837120 12:10:48 INFO - PROCESS | 11294 | 12:10:52 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34610/tests/kraken/driver.html?testName=imaging-desaturate) 12:10:52 INFO - PROCESS | 11294 | RSS: Main: 169885696 12:10:52 INFO - PROCESS | 11294 | 12:10:55 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34610/tests/kraken/driver.html?testName=json-parse-financial) 12:10:56 INFO - PROCESS | 11294 | RSS: Main: 169578496 12:10:56 INFO - PROCESS | 11294 | 12:10:57 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34610/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:10:58 INFO - PROCESS | 11294 | RSS: Main: 175943680 12:10:58 INFO - PROCESS | 11294 | 12:11:00 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34610/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:11:00 INFO - PROCESS | 11294 | RSS: Main: 173670400 12:11:00 INFO - PROCESS | 11294 | 12:11:02 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34610/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:11:03 INFO - PROCESS | 11294 | RSS: Main: 180404224 12:11:03 INFO - PROCESS | 11294 | 12:11:05 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:11:06 INFO - PROCESS | 11294 | RSS: Main: 185004032 12:11:06 INFO - PROCESS | 11294 | 12:11:08 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:11:09 INFO - PROCESS | 11294 | RSS: Main: 183877632 12:11:09 INFO - PROCESS | 11294 | 12:11:10 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:34610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34610/tests/kraken/driver.html?testName=ai-astar) 12:11:11 INFO - PROCESS | 11294 | RSS: Main: 245243904 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | __start_tp_report 12:11:11 INFO - PROCESS | 11294 | _x_x_mozilla_page_load 12:11:11 INFO - PROCESS | 11294 | _x_x_mozilla_page_load_details 12:11:11 INFO - PROCESS | 11294 | |i|pagename|runs| 12:11:11 INFO - PROCESS | 11294 | |0;ai-astar;110;110;106;113;113;109;105;109;110;109 12:11:11 INFO - PROCESS | 11294 | |1;audio-beat-detection;154;125;160;161;128;158;151;127;177;128 12:11:11 INFO - PROCESS | 11294 | |2;audio-dft;161;159;162;161;159;160;162;169;160;160 12:11:11 INFO - PROCESS | 11294 | |3;audio-fft;76;76;77;167;76;76;77;76;166;77 12:11:11 INFO - PROCESS | 11294 | |4;audio-oscillator;92;93;146;92;93;93;141;92;92;147 12:11:11 INFO - PROCESS | 11294 | |5;imaging-gaussian-blur;118;116;116;117;117;117;116;116;117;117 12:11:11 INFO - PROCESS | 11294 | |6;imaging-darkroom;146;145;145;145;146;145;145;146;146;146 12:11:11 INFO - PROCESS | 11294 | |7;imaging-desaturate;95;96;95;96;96;96;96;96;95;95 12:11:11 INFO - PROCESS | 11294 | |8;json-parse-financial;57;58;60;56;59;57;58;65;56;60 12:11:11 INFO - PROCESS | 11294 | |9;json-stringify-tinderbox;64;64;64;65;72;65;66;65;65;65 12:11:11 INFO - PROCESS | 11294 | |10;stanford-crypto-aes;77;79;80;79;79;79;79;77;77;81 12:11:11 INFO - PROCESS | 11294 | |11;stanford-crypto-ccm;112;112;119;111;119;115;121;115;113;118 12:11:11 INFO - PROCESS | 11294 | |12;stanford-crypto-pbkdf2;154;146;143;141;150;135;141;151;142;141 12:11:11 INFO - PROCESS | 11294 | |13;stanford-crypto-sha256-iterative;70;67;70;67;67;65;66;68;65;63 12:11:11 INFO - PROCESS | 11294 | __end_tp_report 12:11:11 INFO - PROCESS | 11294 | __start_cc_report 12:11:11 INFO - PROCESS | 11294 | _x_x_mozilla_cycle_collect,1044 12:11:11 INFO - PROCESS | 11294 | __end_cc_report 12:11:11 INFO - PROCESS | 11294 | __startTimestamp1462561871179__endTimestamp 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | ------- Summary: start ------- 12:11:11 INFO - PROCESS | 11294 | Number of tests: 14 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.55 (2.3%) stddev-sans-first:2.69 12:11:11 INFO - PROCESS | 11294 | Values: 110.0 110.0 106.0 113.0 113.0 109.0 105.0 109.0 110.0 109.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:156.00 stddev:18.43 (11.8%) stddev-sans-first:19.37 12:11:11 INFO - PROCESS | 11294 | Values: 154.0 125.0 160.0 161.0 128.0 158.0 151.0 127.0 177.0 128.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:2.91 (1.8%) stddev-sans-first:3.08 12:11:11 INFO - PROCESS | 11294 | Values: 161.0 159.0 162.0 161.0 159.0 160.0 162.0 169.0 160.0 160.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:38.00 (50.0%) stddev-sans-first:39.72 12:11:11 INFO - PROCESS | 11294 | Values: 76.0 76.0 77.0 167.0 76.0 76.0 77.0 76.0 166.0 77.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:92.00 stddev:25.28 (27.5%) stddev-sans-first:26.14 12:11:11 INFO - PROCESS | 11294 | Values: 92.0 93.0 146.0 92.0 93.0 93.0 141.0 92.0 92.0 147.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 12:11:11 INFO - PROCESS | 11294 | Values: 118.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:11:11 INFO - PROCESS | 11294 | Values: 146.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:11:11 INFO - PROCESS | 11294 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.50 stddev:2.67 (4.6%) stddev-sans-first:2.77 12:11:11 INFO - PROCESS | 11294 | Values: 57.0 58.0 60.0 56.0 59.0 57.0 58.0 65.0 56.0 60.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:2.37 (3.6%) stddev-sans-first:2.45 12:11:11 INFO - PROCESS | 11294 | Values: 64.0 64.0 64.0 65.0 72.0 65.0 66.0 65.0 65.0 65.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:1.34 (1.7%) stddev-sans-first:1.27 12:11:11 INFO - PROCESS | 11294 | Values: 77.0 79.0 80.0 79.0 79.0 79.0 79.0 77.0 77.0 81.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:116.50 stddev:3.54 (3.0%) stddev-sans-first:3.52 12:11:11 INFO - PROCESS | 11294 | Values: 112.0 112.0 119.0 111.0 119.0 115.0 121.0 115.0 113.0 118.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:144.50 stddev:5.78 (4.0%) stddev-sans-first:4.97 12:11:11 INFO - PROCESS | 11294 | Values: 154.0 146.0 143.0 141.0 150.0 135.0 141.0 151.0 142.0 141.0 12:11:11 INFO - PROCESS | 11294 | 12:11:11 INFO - PROCESS | 11294 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:2.20 (3.3%) stddev-sans-first:2.01 12:11:11 INFO - PROCESS | 11294 | Values: 70.0 67.0 70.0 67.0 67.0 65.0 66.0 68.0 65.0 63.0 12:11:11 INFO - PROCESS | 11294 | -------- Summary: end -------- 12:11:11 INFO - PROCESS | 11294 | 12:11:12 INFO - TEST-INFO | 11294: exit 0 12:11:12 INFO - TEST-OK | kraken | took 59241ms 12:11:12 INFO - SUITE-END | took 1170s 12:11:12 INFO - Completed test suite (00:19:30) 12:11:12 INFO - javascript benchmark 12:11:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3285.3593549257894, 3321.7342612590996, 3340.7661463697536, 3342.7492938029654, 3366.764326497145, 5378.193271009346, 5386.48828361306, 5392.379876314225, 5404.486573775494, 5424.159255315428, 5375.381831089426, 5393.6763794172375, 5403.027455058088, 5403.891922161554, 5406.54044406226, 4871.975640121795, 4898.966928724575, 4940.308356830046, 4960.379952505937, 5003.974980125113, 4887.8778030549165, 4907.5583197512215, 4964.304997300381, 4972.229304457815, 4973.751312434382, 4936.580390666798, 5014.924776128361, 5060.822871199509, 5098.464661210575, 5108.514691104339, 5018.0, 5023.0707319145895, 5045.520675535819, 5046.142155833517, 5070.163423035213, 4562.064776720765, 4882.41411030675, 4911.435184953741, 4926.729029903354, 4967.453580106186, 5243.659162154486, 5245.1869960155855, 5246.213068039787, 5257.894842103136, 5299.258103865462, 5715.028445164332, 5773.451522105393, 5824.941750582525, 5845.064789633639, 5853.0635098384055, 5761.971190144064, 5778.335491418498, 5784.219130417382, 5786.594938354317, 5843.094320380305, 5477.917831232495, 5517.917231241495, 5520.696361700065, 5520.834374968757, 5537.224788529609, 5871.2073870027, 5989.101634754735, 6004.849878753066, 6023.66869822164, 6024.457798798129, 5787.450192231731, 5789.421057894261, 5793.362730099686, 5803.361630220672, 5817.301923769175, 5861.9706901465215, 5863.208466857005, 5865.853353666193, 5869.941300587025, 5876.647401155944, 5637.351704554028, 5717.599768016199, 5810.360860305363, 5829.912551311733, 5851.356350801409, 5788.27646544182, 5794.478496935296, 5796.710164491758, 5803.419658034163, 5803.8549036274435, 4382.517923028464, 4426.513083560806, 4429.468463784302, 4432.800523976429, 4448.532904045029, 3949.664278536299, 3969.206158768258, 3981.22366138606, 4039.293123703399, 4079.63283304504, 5484.588655850827, 5495.2856128703015, 5503.7798488060025, 5504.862378440491, 5506.752196151183, 5824.271966004249, 5838.883222335529, 5841.0, 5843.328017278068, 5869.911951320733, 5354.41101478837, 5509.173623956439, 5589.469000444951, 5621.297337832771, 5643.351014633287, 5006.424261210008, 5007.899842003212, 5024.949750502448, 5026.723530205873, 5059.544640982329, 5884.941150588525, 6032.065029920369, 6049.516038716892, 6050.213472248667, 6050.878982420415, 5765.740541675718, 5815.127730840408, 5844.3571207168025, 5851.180834683233, 5853.414658534283, 6013.9097913532205, 6052.90920636182, 6053.243344581927, 6055.5458340623745, 6059.3334733178435, 5697.971510142588, 5771.7402716877, 5834.591578589458, 5841.737121829443, 5861.325947515919, 5871.94128058714, 5901.2033375495475, 5906.557008224487, 5923.229980102731, 5937.970310148422, 5724.169995350568, 5749.396313387034, 5756.740946657326, 5767.336756273083, 5767.452092051249, 5590.86022849432, 5690.886182276248, 5717.914231286617, 5759.625624334405, 5815.534757219328, 5648.124540696199, 5662.094064949588, 5666.829995100154, 5669.149627555899, 5676.602637815313, 5763.4812866842185, 5770.480656740913, 5792.044312688359, 5807.94192058074, 5809.796657116981, 5461.317335333083, 5617.241672374341, 5663.292088488939, 5690.857728556819, 5700.315962084411], "unit": "score", "name": "dojo.html", "value": 5385.662980658485}, {"lowerIsBetter": false, "replicates": [543.9537639300662, 563.4281204577353, 569.5443645083932, 581.1486172756913, 581.7062383496334, 38429.0, 39135.80432097843, 39178.21643567127, 39235.607643923555, 39264.607353926454, 44800.0, 45332.77333613327, 45364.77317613416, 45404.545954540445, 45437.0, 9024.413413128159, 9233.769155771126, 9235.492047937361, 9245.121713437245, 9246.722598322027, 9098.090190980882, 9277.628894844198, 9279.118483744034, 9283.721488355326, 9285.0, 9203.907960920405, 9304.302177336693, 9315.347925645208, 9319.021502742216, 9325.0, 9183.58673859678, 9265.629374825, 9267.165955064009, 9276.16514513697, 9282.767930801716, 8917.108289171096, 9178.265738740885, 9193.678221262224, 9195.770105747342, 9201.079892010745, 41644.0, 42029.57970420287, 42106.15787684229, 42235.7888210557, 42247.577524224675, 3590.35373632746, 3641.6722494975315, 3693.316736403747, 4243.724157929724, 4295.377170310318, 30396.848015760002, 30681.232969175948, 32819.83590082058, 33458.6654133458, 33553.0, 4199.9790001050105, 4236.703430759848, 4244.08752118293, 4264.701470897038, 4276.2516559601945, 294344.0, 295628.0, 295730.0, 296027.0, 296286.0, 45646.543534564895, 62288.688556557834, 62683.0, 62817.68591157015, 62858.371416286165, 43985.0, 44263.0, 44280.3357949631, 44344.0, 44426.77786611046, 15088.0, 15365.154916479702, 15412.922935385252, 15440.768388474182, 15445.922770386076, 10972.561097556169, 11105.333679979227, 11108.722281943015, 11110.277831940897, 11119.833202501968, 15231.771523427158, 15358.769618455508, 15722.764158537631, 15769.29038193284, 15782.0, 5889.911651325234, 5947.167396564484, 6031.60794548353, 6108.816735497942, 6160.630362178284, 1067.7223921780394, 1083.5774048121239, 1090.5223422262877, 1109.6116359274351, 1230.8276841242234, 30091.404229121188, 30211.546826797614, 30500.38999220003, 30628.234294142825, 30660.38679226403, 1132.2753437799815, 1139.632386298486, 1167.5563285951284, 1172.1209093180114, 1175.3594291111365, 15534.922325388527, 15766.9211653941, 15783.131927744083, 15803.288852001457, 16277.348906043626, 331637.0, 333992.0, 335945.0, 336216.0, 336624.0, 56151.438485615436, 56482.7175864118, 56690.716546417, 56975.0, 57064.85870282654, 1362.5707902010636, 1390.2075816784336, 1449.8985071044926, 1455.3596417576232, 1475.2476237119147, 27199.04803331953, 27693.30766730848, 28572.285692857844, 28804.279893002844, 29730.405391892473, 44237.77881110574, 44699.0, 44747.32879006752, 44751.552484476044, 44785.0, 202774.0, 213964.0, 217001.0, 217399.0, 219241.0, 30306.545401819432, 31009.534856977614, 33424.0, 34411.31177376388, 35105.0, 41861.1627767449, 41874.162516750104, 41910.16179676451, 42542.361864572675, 42558.361624576275, 33400.49899251562, 36650.0, 36682.44976325304, 37677.24645507129, 38136.427953581275, 36860.81569592135, 37362.25275494529, 37468.063298416666, 37499.06252343713, 37881.81059094797, 36560.0, 36944.63055369412, 40861.795691021354, 41018.1796364077, 41421.0, 33731.15672108217, 34104.0, 34365.14087147841, 34403.96788096361, 34536.309273814884, 26976.325591859575, 27083.86458067697, 27184.864075679496, 27204.319892002066, 27314.863425682743], "unit": "score", "name": "ext.html", "value": 18681.76663936251}, {"lowerIsBetter": false, "replicates": [373.7682636765204, 381.3764495050592, 386.66939766499627, 395.7585872617703, 396.0336778261043, 17317.393891213793, 18312.633747325046, 18860.905695471505, 18866.811331886678, 18923.716144257847, 11764.411779411039, 12180.451879665414, 12190.207636503621, 12194.878051219484, 12197.0, 5193.922091168635, 5313.57544035636, 5638.097904335307, 5786.68173250471, 5793.333766616851, 5689.6017278790505, 5758.913616295759, 5759.337676167232, 5762.1068734346245, 5789.797357092502, 5338.706371149585, 5556.722163891809, 5562.16567514872, 5726.599138060337, 5741.167530708045, 5502.697351645658, 5504.834854954338, 5509.669419834822, 5542.8337149885365, 5830.3586605473365, 5711.228984087178, 5734.541236701054, 5735.483806457439, 5737.139429085671, 5738.368779434259, 12590.81113783294, 12784.488620455171, 12993.935030324883, 13164.6708832279, 13173.341332933314, 2242.327301809467, 2269.4439862233858, 2311.3874823171873, 2545.3000424883307, 2672.7327267273313, 9134.634614615408, 9392.48341341226, 9980.151687106532, 10931.890681093246, 13785.035047546677, 1940.1075505267595, 1957.0508303472805, 1963.1950900130878, 1969.3008981811538, 1988.9403317900485, 51596.0, 61104.38895611031, 63031.0, 64917.3508264916, 66856.0, 9555.761105972406, 10105.797884042426, 10219.48902554884, 10475.895241047492, 10634.09610183143, 13726.725465490634, 14045.78931316031, 14409.85590144106, 14467.638309042359, 14482.855171448362, 7478.85042299151, 7647.923520764833, 7676.19399963007, 7795.649195786204, 7818.452708310364, 7254.274572542809, 7464.664090115958, 7467.813304667427, 7558.58427786477, 7570.205128461433, 4504.617107545895, 4517.096580683877, 4551.749653769075, 4591.747453890068, 4607.124646317189, 1892.4606487151095, 1927.9325223617107, 1946.9610607787765, 1967.9409617711492, 2016.6874134509173, 975.8097171051577, 992.5434300221834, 999.1557134221571, 1000.3547711725896, 1063.9520072728355, 17406.39077632302, 17548.0, 17656.735148972777, 17759.733603995952, 17969.19138638738, 964.6430820596424, 977.2279898879948, 1007.315025782475, 1022.943738094412, 1063.7659714862718, 9911.908484081578, 10116.797664046826, 10278.22913281507, 10361.740956475998, 10443.373397596017, 418071.0, 422440.0, 426989.0, 428302.0, 435620.0, 72476.27523724695, 74816.62591687006, 75776.0, 76380.0, 77227.0, 988.6539711101057, 988.7132731507926, 997.7505623594102, 1012.6202673997251, 1016.5273147986222, 14720.852791471949, 14874.256287185814, 14926.477573284883, 15181.468648597687, 15232.535590152409, 33747.81882634096, 34043.31913361768, 34279.65720342765, 34381.31237375289, 34695.13262168365, 46933.53066469292, 48019.75990120027, 48650.756746216044, 48662.756686216344, 48894.75552622214, 8319.292860106958, 8369.83260334802, 8385.496870187808, 8469.57652117404, 8578.528180950108, 11656.88343116558, 12687.0, 12900.935495322463, 13283.269420181983, 13325.466981320638, 11386.316820990767, 11421.486033128363, 11748.823767643664, 11766.470508827295, 11847.703807404883, 11400.828987565359, 11469.426528673366, 11650.184487086162, 11784.175107742376, 11898.881011189776, 11427.828582571434, 11552.595659152226, 11598.478068487108, 11812.055035597303, 11929.0, 8209.384296177692, 8247.463914845515, 8428.873566896624, 8492.702755403778, 8494.74515764528, 10736.194785390971, 11177.105831533621, 11210.103191744804, 11600.49193604826, 11680.591179308683], "unit": "score", "name": "jquery.html", "value": 8541.18384116226}, {"lowerIsBetter": false, "replicates": [1430.9141451512903, 1525.938962441502, 1542.73773458512, 1735.4273089880342, 1850.518865095075, 7503.13713922899, 7922.524648521093, 8052.154523775, 8054.798630034252, 8064.71773487928, 8195.795105122375, 8388.66445342187, 8391.076981532027, 8395.664173433055, 8396.45423047503, 2367.7987371073436, 2387.892544835478, 2393.5811233034237, 2394.365493144318, 2394.748551402095, 2362.7637236276405, 2375.798057165134, 2437.549053425113, 2443.144899285254, 2463.1625247415873, 2403.9158629447975, 2404.663347131403, 2414.082648593541, 2436.4030812450974, 2437.9634305485433, 2391.414103544634, 2400.6879105716234, 2401.9519609607796, 2419.2863105383776, 2471.209213051824, 2365.757977062039, 2410.3974006498374, 2418.5646583614944, 2421.237310247284, 2423.648570957201, 8247.670093196264, 8541.35939804511, 8565.957170214171, 8566.186212309884, 8573.442726222776, 5097.184450487941, 5208.609354298443, 5215.739213039371, 5218.895622087575, 5218.947810521884, 3251.0246925922365, 3255.3814775192636, 3277.7869438486423, 3290.7367410607094, 3336.199312165087, 1030.006044167382, 2018.3137733170793, 2041.7856125106798, 2105.3683894831643, 2110.1137522240697, 11383.0, 11461.140414469031, 11477.827832582518, 11489.597864074718, 11490.080793536581, 4359.542248063907, 4509.842155524607, 4540.455145382509, 4594.310853371954, 4601.631869450436, 9420.576074076684, 9470.810583788423, 9471.810563788824, 9473.100055494717, 9476.478793666414, 5130.358705161855, 5156.097682905476, 5164.328637277205, 5169.353830771153, 5173.456787037382, 4132.504099508018, 4200.810963506649, 4248.957510424856, 4411.823527058946, 4768.1417344878255, 3859.1124041470057, 3931.8427262909736, 3934.0361611405388, 3942.8817135485983, 3982.5021872265966, 1265.8101284807353, 1267.461328935199, 1274.1654216488214, 1279.635303938373, 1281.090425797694, 1440.0495672855866, 1456.9490067847576, 1464.9414023439156, 1479.9334029968677, 1487.732208202534, 7937.642806073625, 8067.435279530494, 8141.79645508867, 8167.060788009336, 8170.509769413854, 514.6371807875514, 526.6603041038509, 531.1183435497056, 537.0815904802831, 537.6639600249844, 6184.134221208944, 6210.72051757672, 6237.844053898689, 6243.094751261133, 6295.622262664255, 9892.703218903445, 10389.0, 10392.220583456272, 10406.947965260126, 10415.375077495375, 9499.762505937408, 10159.695209143738, 10224.335418197794, 10256.641017564349, 10261.640842570474, 7592.620368981528, 7732.922670773332, 7771.727989520453, 7807.297343239135, 7808.609569521501, 7726.1501234863, 7835.882461763192, 7864.4888082274465, 7931.325837303893, 7947.403944704055, 8709.956450217709, 8860.64557417696, 8946.239569636653, 9165.083491650781, 9173.082691730773, 8997.235235004837, 9114.817703646022, 9121.133492318218, 9234.584443699916, 9247.0752924707, 6727.058211850247, 6961.756338528127, 7155.749548765768, 7391.889121663072, 7485.588292643739, 8027.879581806161, 8039.879401809095, 8054.919450805417, 8122.959385203036, 8129.634166462405, 7139.32176443237, 7191.892121618075, 7234.493585448968, 7249.637518124178, 7487.47587668858, 7074.752383666547, 7159.0, 7160.283971602798, 7264.0, 7276.781696549112, 7619.809504762204, 7740.148583655906, 7752.496087754278, 7758.4181186410115, 7765.572893490912, 6950.721971121301, 6952.304769523007, 6985.895211571932, 7002.929970700227, 7017.122859642544, 6922.8961565577565, 7121.252268511939, 7143.071400717873, 7145.1783044948415, 7156.427485801019], "unit": "score", "name": "mootools.html", "value": 4786.761396948968}, {"lowerIsBetter": false, "replicates": [329.18855022369854, 331.8423748719358, 336.25016213843145, 337.4634331413054, 339.67900334184196, 5970.910436343458, 5972.492338151263, 6014.127951447038, 6028.939710602893, 6038.245219347582, 5970.522358211343, 5972.223610930584, 5985.8204253872345, 5989.790357337494, 5996.220491336131, 4468.731876087429, 4552.9089418211615, 4629.4444666639965, 4657.906841863178, 4703.318018887259, 4672.3692301539195, 4688.156131896258, 4692.835750748724, 4694.2723877799, 4701.60036396905, 4636.814527418916, 4639.884002899921, 4648.837290694826, 4652.116097941397, 4661.114388266218, 4443.311286750559, 4515.05183911379, 4566.0, 4585.151746926796, 4603.746793926332, 4043.6158564936286, 4051.0682543014977, 4059.944414452234, 4066.8169932353117, 4069.3285607874664, 5703.144528320744, 5736.340320863071, 5746.885062298772, 5748.655080695172, 5756.856078598027, 5399.0, 5399.19012148177, 5408.026555220059, 5410.513053825135, 5417.891642167135, 6341.302456729756, 6346.936530634727, 6349.52378571609, 6357.904631430532, 6363.395477429637, 4255.680823938217, 4358.825646974117, 4376.146651402978, 4404.273294906337, 4532.388127602764, 6563.606183628997, 6610.173728283965, 6611.50413718973, 6626.801195964081, 6628.966855165741, 4457.888552786207, 4458.219811532968, 4465.37484752135, 4467.0, 4473.977630111894, 4515.954840451619, 4522.4346956630425, 4522.909541809146, 4522.954770452319, 4523.5024147343765, 5265.104932161542, 5269.815556455505, 5273.683578985273, 5281.234221038005, 5285.2600635911, 6189.81430557084, 6336.239651241788, 6412.198475190601, 6429.324920883333, 6430.0, 1574.8818838587151, 1586.2623879895673, 1597.0258142533046, 1597.0258142533278, 1604.0455928722392, 995.8058178655093, 1035.1098055672117, 1038.4651904269156, 1041.1930753665818, 1063.1388575254068, 6049.062395328731, 6066.817995460143, 6069.484093852072, 6070.6357618543025, 6076.817695469143, 6414.069959855795, 6484.740610375532, 6526.0, 6528.771492997817, 6544.836379090466, 6140.600860944024, 6145.692715364214, 6148.077788331786, 6152.969235153795, 6156.0, 3426.674465925733, 3487.4245749451566, 3514.4728290756593, 3516.5955915069585, 3518.1908161122574, 6327.968360158262, 6487.772927947499, 6660.367265109807, 6732.259451460335, 6734.595924244561, 6614.570052946543, 6665.166854143232, 6690.966545167243, 6693.899591506131, 6876.277990810993, 6887.483438742114, 6887.758928437481, 6932.272111428228, 6933.618650974245, 6969.128858892638, 6651.102101216274, 6664.83337916556, 6721.294264102199, 6736.66316684154, 6739.73041078371, 6566.540342176002, 6572.309907459839, 6583.967080164569, 6586.407223349922, 6587.0, 6710.228323742832, 6817.795466136024, 6847.109875716125, 6858.862822743417, 6860.965695171692, 4525.547445255448, 4547.909041819211, 4562.5665561771575, 4568.840090596813, 4572.88567785808, 6640.203175618956, 6648.434883034996, 6650.235222949423, 6659.0, 6664.866702665822, 6458.0, 6469.967650161719, 6475.352464753675, 6476.773312934025, 6479.5788273762055, 6461.547691661539, 6467.708953097028, 6468.838279043061, 6481.157449531531, 6485.578437401554, 6112.938870611415, 6243.750249989949, 6259.374062593704, 6306.747730090745, 6355.173827402408, 6446.5165112615805, 6478.643674597943, 6479.967600161969, 6495.317991611002, 6500.057491663777, 6338.619682819046, 6345.302016778059, 6346.111544383883, 6359.046143078575, 6361.395667411589], "unit": "score", "name": "prototype.html", "value": 4810.452815037551}, {"lowerIsBetter": false, "replicates": [780.7267456390264, 805.5529181304373, 871.1201686296839, 901.48164805237, 909.8726178335032, 14509.92745036276, 14537.709245815078, 14632.268386580668, 14646.048006879559, 14681.0, 13791.448342066305, 13896.096753711001, 13941.0, 14014.299285035733, 14022.509212177576, 901.7790641292893, 912.703371404293, 919.9264058875274, 920.1672486399785, 920.2545937790378, 908.0919080919081, 910.658503061352, 912.4114945859916, 913.5067063785581, 913.5569248914271, 964.5852283518085, 966.8936416994125, 969.5103972493916, 969.7236287658019, 969.883613966325, 954.9140577348037, 960.1214888377126, 960.4141473701037, 961.053362438005, 962.2494454325567, 712.2130046298869, 712.565335145566, 712.5795780489536, 712.7362875735959, 713.9178994415656, 13781.448742050306, 13811.240381778998, 13811.930940345335, 13816.0, 13845.376958036912, 12510.37448127599, 12538.122331436804, 12546.372681365896, 12649.304288264142, 12864.678383040406, 10594.152467802558, 10810.621628242974, 10911.181661375429, 11021.118310535137, 11082.501287442085, 3734.6638802507905, 3866.961330386688, 3868.9226215475533, 3871.9419208711893, 3891.5913829047827, 50536.241956370315, 50663.0, 50769.0, 50942.74528627333, 51759.48240517584, 9740.464274464972, 9827.950860245795, 9938.751531211778, 9958.900410995942, 10021.34861234032, 18462.44612661622, 18544.907275463538, 18564.071796410124, 18589.81410185908, 18636.72044919327, 7875.173106823816, 8095.676172953016, 8317.085120636724, 8361.623726932181, 8381.28759055475, 4566.4063671723125, 4758.3100450434495, 4799.136155491975, 4833.154198015403, 4881.316615673809, 3329.93340133196, 3364.1925937775245, 3372.1401042733946, 3373.6795004474534, 3373.8481768320485, 583.3175185033521, 609.2719200555382, 611.3794498583941, 612.8069658057698, 625.7684656677059, 644.9193850768654, 678.6810199206365, 678.759040540601, 719.4100837313352, 724.4457989637931, 8127.918720812834, 8280.0, 8339.666413343519, 8550.871736923951, 8632.223099920911, 664.4020381656451, 670.1321788284183, 674.153936809311, 709.0817391478048, 729.5221629832469, 3985.2826491231276, 4143.937840932388, 4147.52303485103, 4175.89621844985, 4312.913741725148, 60677.39322606717, 60948.390516094274, 60950.695246523486, 62124.0, 62137.68931155315, 43062.78468607637, 53597.1960420594, 54277.1858422124, 54460.45539544554, 54704.45295546993, 46147.76926115348, 46260.0, 50097.74951125221, 50595.49404505908, 51307.0, 8612.526311052952, 8652.610632521426, 8661.8700719488, 8682.43564168327, 8877.422967507091, 36137.0965725859, 36254.27491450103, 36871.262574747816, 37718.62281377151, 38462.42306365351, 47235.76382118068, 47679.0, 48013.759931201515, 49115.0, 49880.750596246784, 11063.50214240345, 11098.778024439627, 11357.204995650225, 12075.456604452645, 12508.937455312665, 11122.3326600401, 11187.272827266203, 11285.548578056785, 11967.341796201292, 12127.151099422956, 11119.44402779874, 12513.937430313154, 12703.0, 12866.871331286942, 13036.543720969721, 12058.75882482363, 12096.153269271419, 12691.365431728193, 12763.170393924365, 12978.870211297766, 11231.746917146416, 11505.884941150816, 11728.179027467995, 11745.706357341134, 11950.820737689115, 9689.176420004378, 10042.447665378182, 10506.789864202521, 10634.255602108087, 10740.624078157227, 9925.654434660792, 10325.277230594087, 10375.4027524538, 10436.321639093434, 10510.159187265153], "unit": "score", "name": "yui.html", "value": 6701.390573663692}], "name": "dromaeo_css", "value": 7141.135110002016}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 113.0, 113.0, 109.0, 105.0, 109.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [154.0, 125.0, 160.0, 161.0, 128.0, 158.0, 151.0, 127.0, 177.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 162.0, 161.0, 159.0, 160.0, 162.0, 169.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 77.0, 167.0, 76.0, 76.0, 77.0, 76.0, 166.0, 77.0], "unit": "score", "name": "audio-fft", "value": 94.4}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 146.0, 92.0, 93.0, 93.0, 141.0, 92.0, 92.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 60.0, 56.0, 59.0, 57.0, 58.0, 65.0, 56.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 72.0, 65.0, 66.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.5}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 80.0, 79.0, 79.0, 79.0, 79.0, 77.0, 77.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.7}, {"lowerIsBetter": true, "replicates": [112.0, 112.0, 119.0, 111.0, 119.0, 115.0, 121.0, 115.0, 113.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.5}, {"lowerIsBetter": true, "replicates": [154.0, 146.0, 143.0, 141.0, 150.0, 135.0, 141.0, 151.0, 142.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 70.0, 67.0, 67.0, 65.0, 66.0, 68.0, 65.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1507.4}]} 12:11:12 INFO - Return code: 0 12:11:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:11:12 INFO - # TBPL SUCCESS # 12:11:12 INFO - Running post-action listener: _resource_record_post_action 12:11:12 INFO - Running post-run listener: _resource_record_post_run 12:11:13 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 12288; Write bytes: 449581056; Read time: 24; Write time: 332696 12:11:13 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 238153728; Read time: 0; Write time: 212876 12:11:13 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 12288; Write bytes: 211427328; Read time: 24; Write time: 119820 12:11:13 INFO - Running post-run listener: _upload_blobber_files 12:11:13 INFO - Blob upload gear active. 12:11:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:11:13 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 12:11:13 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'] 12:11:13 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 12:11:14 INFO - (blobuploader) - INFO - Open directory for files ... 12:11:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:11:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:11:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:14 INFO - (blobuploader) - INFO - Done attempting. 12:11:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:11:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:11:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:16 INFO - (blobuploader) - INFO - Done attempting. 12:11:16 INFO - (blobuploader) - INFO - Iteration through files over. 12:11:16 INFO - Return code: 0 12:11:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:11:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:11:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec63f39afd3fecba64aa1cf911c93873be9360a48998dcb2ead6c2eed719bfd0848abaad0dab0a28c1f399c76f5202c8192495d261f6841407457f12471732fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff949f4d019bf3624c6925185c0751dbba0b1028dc070fa809872805badf67dd50b80990cf278a5a4d72bf2077359d3f550fcdc2e76b0148af39db9dd2dd3223"} 12:11:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:11:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:11:16 INFO - Contents: 12:11:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec63f39afd3fecba64aa1cf911c93873be9360a48998dcb2ead6c2eed719bfd0848abaad0dab0a28c1f399c76f5202c8192495d261f6841407457f12471732fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff949f4d019bf3624c6925185c0751dbba0b1028dc070fa809872805badf67dd50b80990cf278a5a4d72bf2077359d3f550fcdc2e76b0148af39db9dd2dd3223"} 12:11:16 INFO - Running post-run listener: copy_logs_to_upload_dir 12:11:16 INFO - Copying logs to upload dir... 12:11:16 INFO - mkdir: /builds/slave/test/build/upload/logs 12:11:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.582577 ========= master_lag: 0.54 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-06 12:11:17.249992) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 12:11:17.257911) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567 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/ec63f39afd3fecba64aa1cf911c93873be9360a48998dcb2ead6c2eed719bfd0848abaad0dab0a28c1f399c76f5202c8192495d261f6841407457f12471732fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff949f4d019bf3624c6925185c0751dbba0b1028dc070fa809872805badf67dd50b80990cf278a5a4d72bf2077359d3f550fcdc2e76b0148af39db9dd2dd3223"} build_url:https://queue.taskcluster.net/v1/task/So4VtklCQf6wPLs0ORnexw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/So4VtklCQf6wPLs0ORnexw/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/ec63f39afd3fecba64aa1cf911c93873be9360a48998dcb2ead6c2eed719bfd0848abaad0dab0a28c1f399c76f5202c8192495d261f6841407457f12471732fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff949f4d019bf3624c6925185c0751dbba0b1028dc070fa809872805badf67dd50b80990cf278a5a4d72bf2077359d3f550fcdc2e76b0148af39db9dd2dd3223"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 12:11:17.282253) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 12:11:17.285619) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462560393.685173-610437567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 12:11:17.335212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 12:11:17.338569) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 12:11:17.338877) ========= ========= Total master_lag: 0.66 =========