builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1467036556.81 results: success (0) buildid: 20160627060238 builduid: 4106569c020d4999af6ad3f35d2e4916 revision: 2fb323237cf5b1bab10bc0b5de80bca761607039 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:16.811343) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:16.811906) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:16.812243) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:16.827897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:16.828310) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 07:09:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2016-06-27 07:09:20 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120631 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:16.972750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:16.973174) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018689 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:17.025404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:17.025924) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 2fb323237cf5b1bab10bc0b5de80bca761607039 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 2fb323237cf5b1bab10bc0b5de80bca761607039 --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=6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 07:09:20,355 truncating revision to first 12 chars 2016-06-27 07:09:20,355 Setting DEBUG logging. 2016-06-27 07:09:20,355 attempt 1/10 2016-06-27 07:09:20,355 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/2fb323237cf5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 07:09:20,724 unpacking tar archive at: larch-2fb323237cf5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689419 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:17.731720) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:17.732159) ========= script_repo_revision: 2fb323237cf5b1bab10bc0b5de80bca761607039 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:17.732686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:17.733057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 07:09:17.744157) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-27 07:09:17.744524) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] 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=6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:09:21 INFO - MultiFileLogger online at 20160627 07:09:21 in /builds/slave/test 07:09:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 07:09:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:09:21 INFO - {'append_to_log': False, 07:09:21 INFO - 'base_work_dir': '/builds/slave/test', 07:09:21 INFO - 'blob_upload_branch': 'Larch', 07:09:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:09:21 INFO - 'branch': 'Larch', 07:09:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:09:21 INFO - 'config_files': ('talos/linux_config.py',), 07:09:21 INFO - 'default_actions': ('clobber', 07:09:21 INFO - 'read-buildbot-config', 07:09:21 INFO - 'download-and-extract', 07:09:21 INFO - 'populate-webroot', 07:09:21 INFO - 'create-virtualenv', 07:09:21 INFO - 'install', 07:09:21 INFO - 'run-tests'), 07:09:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:09:21 INFO - 'download_minidump_stackwalk': True, 07:09:21 INFO - 'download_symbols': 'ondemand', 07:09:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:09:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:09:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:09:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:09:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:09:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:09:21 INFO - 'installer_path': 'installer.exe', 07:09:21 INFO - 'log_level': 'info', 07:09:21 INFO - 'log_name': 'talos', 07:09:21 INFO - 'log_to_console': True, 07:09:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:09:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:09:21 INFO - 'opt_config_files': (), 07:09:21 INFO - 'pip_index': False, 07:09:21 INFO - 'sps_profile': False, 07:09:21 INFO - 'sps_profile_interval': 0, 07:09:21 INFO - 'suite': 'dromaeojs', 07:09:21 INFO - 'system_bits': '32', 07:09:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:09:21 INFO - 'title': 'talos-linux64-ix-023', 07:09:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:09:21 INFO - 'use_talos_json': True, 07:09:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:09:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:09:21 INFO - 'work_dir': 'build'} 07:09:21 INFO - ##### 07:09:21 INFO - ##### Running clobber step. 07:09:21 INFO - ##### 07:09:21 INFO - Running pre-action listener: _resource_record_pre_action 07:09:21 INFO - Running main action method: clobber 07:09:21 INFO - rmtree: /builds/slave/test/build 07:09:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:09:21 INFO - Running post-action listener: _resource_record_post_action 07:09:21 INFO - ##### 07:09:21 INFO - ##### Running read-buildbot-config step. 07:09:21 INFO - ##### 07:09:21 INFO - Running pre-action listener: _resource_record_pre_action 07:09:21 INFO - Running main action method: read_buildbot_config 07:09:21 INFO - Using buildbot properties: 07:09:21 INFO - { 07:09:21 INFO - "project": "", 07:09:21 INFO - "product": "firefox", 07:09:21 INFO - "script_repo_revision": "production", 07:09:21 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 07:09:21 INFO - "repository": "", 07:09:21 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 07:09:21 INFO - "buildid": "20160627060238", 07:09:21 INFO - "pgo_build": "False", 07:09:21 INFO - "basedir": "/builds/slave/test", 07:09:21 INFO - "buildnumber": 7, 07:09:21 INFO - "slavename": "talos-linux64-ix-023", 07:09:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:09:21 INFO - "platform": "ubuntu64_hw", 07:09:21 INFO - "scheduler": "tests-larch-linux64-talos", 07:09:21 INFO - "branch": "larch", 07:09:21 INFO - "repo_path": "projects/larch", 07:09:21 INFO - "revision": "2fb323237cf5b1bab10bc0b5de80bca761607039", 07:09:21 INFO - "stage_platform": "linux64", 07:09:21 INFO - "builduid": "4106569c020d4999af6ad3f35d2e4916", 07:09:21 INFO - "slavebuilddir": "test" 07:09:21 INFO - } 07:09:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2. 07:09:21 INFO - Running post-action listener: _resource_record_post_action 07:09:21 INFO - ##### 07:09:21 INFO - ##### Running download-and-extract step. 07:09:21 INFO - ##### 07:09:21 INFO - Running pre-action listener: _resource_record_pre_action 07:09:21 INFO - Running main action method: download_and_extract 07:09:21 INFO - mkdir: /builds/slave/test/build/tests 07:09: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')]} 07:09:21 INFO - https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:09:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.test_packages.json 07:09:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.test_packages.json 07:09:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.test_packages.json 07:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:09:24 INFO - Downloaded 1448 bytes. 07:09:24 INFO - Reading from file /builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.test_packages.json 07:09:24 INFO - Using the following test package requirements: 07:09:24 INFO - {u'common': [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip'], 07:09:24 INFO - u'cppunittest': [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', 07:09:24 INFO - u'firefox-47.0.1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:09:24 INFO - u'gtest': [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', 07:09:24 INFO - u'firefox-47.0.1.en-US.linux-x86_64.gtest.tests.zip'], 07:09:24 INFO - u'jittest': [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', 07:09:24 INFO - u'jsshell-linux-x86_64.zip'], 07:09:24 INFO - u'mochitest': [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', 07:09:24 INFO - u'firefox-47.0.1.en-US.linux-x86_64.mochitest.tests.zip'], 07:09:24 INFO - u'mozbase': [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip'], 07:09:24 INFO - u'reftest': [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', 07:09:24 INFO - u'firefox-47.0.1.en-US.linux-x86_64.reftest.tests.zip'], 07:09:24 INFO - u'talos': [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', 07:09:24 INFO - u'firefox-47.0.1.en-US.linux-x86_64.talos.tests.zip'], 07:09:24 INFO - u'web-platform': [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', 07:09:24 INFO - u'firefox-47.0.1.en-US.linux-x86_64.web-platform.tests.zip'], 07:09:24 INFO - u'webapprt': [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip'], 07:09:24 INFO - u'xpcshell': [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', 07:09:24 INFO - u'firefox-47.0.1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:09:24 INFO - Downloading packages: [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:09: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')]} 07:09:24 INFO - https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip 07:09:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip 07:09:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip 07:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:25 INFO - Downloaded 22140716 bytes. 07:09:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:27 INFO - Return code: 0 07:09:27 INFO - Downloading packages: [u'firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:09:27 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')]} 07:09:27 INFO - https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip 07:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip 07:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip 07:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:31 INFO - Downloaded 22140716 bytes. 07:09:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:32 INFO - Return code: 0 07:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:32 INFO - https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.talos.tests.zip 07:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.talos.tests.zip 07:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.talos.tests.zip 07:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:09:33 INFO - Downloaded 10845194 bytes. 07:09:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:09:33 INFO - Return code: 0 07:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:33 INFO - https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:09:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2 07:09:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2 07:09:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2 07:09:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:09:35 INFO - Downloaded 59001299 bytes. 07:09:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2 07:09:35 INFO - mkdir: /builds/slave/test/properties 07:09:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:35 INFO - Contents: 07:09:35 INFO - build_url:https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2 07:09:36 INFO - Running post-action listener: _resource_record_post_action 07:09:36 INFO - Running post-action listener: set_extra_try_arguments 07:09:36 INFO - ##### 07:09:36 INFO - ##### Running populate-webroot step. 07:09:36 INFO - ##### 07:09:36 INFO - Running pre-action listener: _resource_record_pre_action 07:09:36 INFO - Running main action method: populate_webroot 07:09:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:36 INFO - '--tppagecycles', 07:09:36 INFO - '7'], 07:09:36 INFO - 'tests': ['tsvgm']}}, 07:09:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:09:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:09:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:09:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:09:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:09:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:36 INFO - 'talos_options': ['--e10s'], 07:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:36 INFO - 'tests': ['damp', 'tps']}, 07:09:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:36 INFO - 'talos_options': ['--e10s'], 07:09:36 INFO - 'tests': ['damp', 'tps']}, 07:09:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:09:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:36 INFO - 'other': {'tests': ['a11yr', 07:09:36 INFO - 'ts_paint', 07:09:36 INFO - 'tpaint', 07:09:36 INFO - 'sessionrestore', 07:09:36 INFO - 'sessionrestore_no_auto_restore', 07:09:36 INFO - 'tabpaint']}, 07:09:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:09:36 INFO - 'tests': ['a11yr', 07:09:36 INFO - 'ts_paint', 07:09:36 INFO - 'tpaint', 07:09:36 INFO - 'sessionrestore', 07:09:36 INFO - 'sessionrestore_no_auto_restore', 07:09:36 INFO - 'tabpaint']}, 07:09:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:09:36 INFO - 'tests': ['a11yr', 07:09:36 INFO - 'ts_paint', 07:09:36 INFO - 'tpaint', 07:09:36 INFO - 'sessionrestore', 07:09:36 INFO - 'sessionrestore_no_auto_restore', 07:09:36 INFO - 'tabpaint']}, 07:09:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:09:36 INFO - 'tests': ['a11yr', 07:09:36 INFO - 'ts_paint', 07:09:36 INFO - 'tpaint', 07:09:36 INFO - 'sessionrestore', 07:09:36 INFO - 'sessionrestore_no_auto_restore', 07:09:36 INFO - 'tabpaint']}, 07:09:36 INFO - 'other_l64': {'tests': ['a11yr', 07:09:36 INFO - 'ts_paint', 07:09:36 INFO - 'tpaint', 07:09:36 INFO - 'sessionrestore', 07:09:36 INFO - 'sessionrestore_no_auto_restore', 07:09:36 INFO - 'tabpaint']}, 07:09:36 INFO - 'other_nol64': {'tests': ['a11yr', 07:09:36 INFO - 'ts_paint', 07:09:36 INFO - 'tpaint', 07:09:36 INFO - 'sessionrestore', 07:09:36 INFO - 'sessionrestore_no_auto_restore', 07:09:36 INFO - 'tabpaint']}, 07:09:36 INFO - 'svgr': {'tests': ['tsvgx', 07:09:36 INFO - 'tsvgr_opacity', 07:09:36 INFO - 'tart', 07:09:36 INFO - 'tscrollx', 07:09:36 INFO - 'cart']}, 07:09:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:09:36 INFO - 'tests': ['tsvgx', 07:09:36 INFO - 'tsvgr_opacity', 07:09:36 INFO - 'tart', 07:09:36 INFO - 'tscrollx', 07:09:36 INFO - 'cart']}, 07:09:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:36 INFO - 'tests': ['tp5o']}, 07:09:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:36 INFO - 'talos_options': ['--e10s'], 07:09:36 INFO - 'tests': ['tp5o']}, 07:09:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:36 INFO - 'talos_options': ['--xperf_path', 07:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:36 INFO - 'tests': ['tp5n']}, 07:09:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:36 INFO - 'talos_options': ['--e10s', 07:09:36 INFO - '--xperf_path', 07:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:36 INFO - 'tests': ['tp5n']}}, 07:09:36 INFO - 'talos.zip': {'path': '', 07:09:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:36 INFO - Running post-action listener: _resource_record_post_action 07:09:36 INFO - ##### 07:09:36 INFO - ##### Running create-virtualenv step. 07:09:36 INFO - ##### 07:09:36 INFO - Running pre-action listener: _resource_record_pre_action 07:09:36 INFO - Running main action method: create_virtualenv 07:09:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:36 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 07:09:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:36 INFO - Using real prefix '/usr' 07:09:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:36 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:38 INFO - Installing pip.................done. 07:09:38 INFO - Return code: 0 07:09:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92649f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e160>, '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 0x104f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', '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 07:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:09:38 INFO - Using env: {'DISPLAY': ':0', 07:09:38 INFO - 'HOME': '/home/cltbld', 07:09:38 INFO - 'LANG': 'en_US.UTF-8', 07:09:38 INFO - 'LANGUAGE': 'en_US:en', 07:09:38 INFO - 'LOGNAME': 'cltbld', 07:09:38 INFO - 'MAIL': '/var/mail/cltbld', 07:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:38 INFO - 'MOZ_NO_REMOTE': '1', 07:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:38 INFO - 'NO_EM_RESTART': '1', 07:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:38 INFO - 'PWD': '/builds/slave/test', 07:09:38 INFO - 'SHELL': '/bin/bash', 07:09:38 INFO - 'SHLVL': '1', 07:09:38 INFO - 'TERM': 'linux', 07:09:38 INFO - 'TMOUT': '86400', 07:09:38 INFO - 'USER': 'cltbld', 07:09:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', 07:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:38 INFO - '_': '/tools/buildbot/bin/python'} 07:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:38 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 07:09:38 INFO - Cleaning up... 07:09:38 INFO - Return code: 0 07:09:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f92649f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e160>, '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 0x104f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', '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 07:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:09:38 INFO - Using env: {'DISPLAY': ':0', 07:09:38 INFO - 'HOME': '/home/cltbld', 07:09:38 INFO - 'LANG': 'en_US.UTF-8', 07:09:38 INFO - 'LANGUAGE': 'en_US:en', 07:09:38 INFO - 'LOGNAME': 'cltbld', 07:09:38 INFO - 'MAIL': '/var/mail/cltbld', 07:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:38 INFO - 'MOZ_NO_REMOTE': '1', 07:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:38 INFO - 'NO_EM_RESTART': '1', 07:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:38 INFO - 'PWD': '/builds/slave/test', 07:09:38 INFO - 'SHELL': '/bin/bash', 07:09:38 INFO - 'SHLVL': '1', 07:09:38 INFO - 'TERM': 'linux', 07:09:38 INFO - 'TMOUT': '86400', 07:09:38 INFO - 'USER': 'cltbld', 07:09:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', 07:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:38 INFO - '_': '/tools/buildbot/bin/python'} 07:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:39 INFO - Downloading/unpacking psutil>=0.7.1 07:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:41 INFO - Installing collected packages: psutil 07:09:41 INFO - Running setup.py install for psutil 07:09:41 INFO - building 'psutil._psutil_linux' extension 07:09:41 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 07:09:41 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 07:09:41 INFO - building 'psutil._psutil_posix' extension 07:09:41 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 07:09:41 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 07:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:41 INFO - Successfully installed psutil 07:09:41 INFO - Cleaning up... 07:09:41 INFO - Return code: 0 07:09:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:41 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 0x7f92649f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e160>, '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 0x104f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', '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 07:09:41 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 07:09:41 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 07:09:41 INFO - Using env: {'DISPLAY': ':0', 07:09:41 INFO - 'HOME': '/home/cltbld', 07:09:41 INFO - 'LANG': 'en_US.UTF-8', 07:09:41 INFO - 'LANGUAGE': 'en_US:en', 07:09:41 INFO - 'LOGNAME': 'cltbld', 07:09:41 INFO - 'MAIL': '/var/mail/cltbld', 07:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:41 INFO - 'MOZ_NO_REMOTE': '1', 07:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:41 INFO - 'NO_EM_RESTART': '1', 07:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:41 INFO - 'PWD': '/builds/slave/test', 07:09:41 INFO - 'SHELL': '/bin/bash', 07:09:41 INFO - 'SHLVL': '1', 07:09:41 INFO - 'TERM': 'linux', 07:09:41 INFO - 'TMOUT': '86400', 07:09:41 INFO - 'USER': 'cltbld', 07:09:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', 07:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:41 INFO - '_': '/tools/buildbot/bin/python'} 07:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:09:44 INFO - Installing collected packages: mozsystemmonitor 07:09:44 INFO - Running setup.py install for mozsystemmonitor 07:09:44 INFO - Successfully installed mozsystemmonitor 07:09:44 INFO - Cleaning up... 07:09:44 INFO - Return code: 0 07:09:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:44 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 0x7f92649f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e160>, '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 0x104f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', '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 07:09:44 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 07:09:44 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 07:09:44 INFO - Using env: {'DISPLAY': ':0', 07:09:44 INFO - 'HOME': '/home/cltbld', 07:09:44 INFO - 'LANG': 'en_US.UTF-8', 07:09:44 INFO - 'LANGUAGE': 'en_US:en', 07:09:44 INFO - 'LOGNAME': 'cltbld', 07:09:44 INFO - 'MAIL': '/var/mail/cltbld', 07:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:44 INFO - 'MOZ_NO_REMOTE': '1', 07:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:44 INFO - 'NO_EM_RESTART': '1', 07:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:44 INFO - 'PWD': '/builds/slave/test', 07:09:44 INFO - 'SHELL': '/bin/bash', 07:09:44 INFO - 'SHLVL': '1', 07:09:44 INFO - 'TERM': 'linux', 07:09:44 INFO - 'TMOUT': '86400', 07:09:44 INFO - 'USER': 'cltbld', 07:09:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', 07:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:44 INFO - '_': '/tools/buildbot/bin/python'} 07:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:44 INFO - Downloading/unpacking blobuploader==1.2.4 07:09:44 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 07:09:44 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 07:09:44 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 07:09:44 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 07:09:44 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 07:09:44 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 07:09:46 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09:46 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 07:09:46 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 07:09:46 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 07:09:46 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 07:09:46 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 07:09:46 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 07:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:09:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09:47 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 07:09:47 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 07:09:47 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 07:09:47 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 07:09:47 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 07:09:47 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 07:09:47 INFO - Downloading docopt-0.6.1.tar.gz 07:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:47 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:47 INFO - Running setup.py install for blobuploader 07:09:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:09:47 INFO - Running setup.py install for requests 07:09:47 INFO - Running setup.py install for docopt 07:09:47 INFO - Successfully installed blobuploader requests docopt 07:09:47 INFO - Cleaning up... 07:09:47 INFO - Return code: 0 07:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:47 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')]} 07:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:47 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')]} 07:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:47 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 0x7f92649f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e160>, '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 0x104f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', '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 07:09:47 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 07:09:47 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 07:09:47 INFO - Using env: {'DISPLAY': ':0', 07:09:47 INFO - 'HOME': '/home/cltbld', 07:09:47 INFO - 'LANG': 'en_US.UTF-8', 07:09:47 INFO - 'LANGUAGE': 'en_US:en', 07:09:47 INFO - 'LOGNAME': 'cltbld', 07:09:47 INFO - 'MAIL': '/var/mail/cltbld', 07:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:47 INFO - 'MOZ_NO_REMOTE': '1', 07:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:47 INFO - 'NO_EM_RESTART': '1', 07:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:47 INFO - 'PWD': '/builds/slave/test', 07:09:47 INFO - 'SHELL': '/bin/bash', 07:09:47 INFO - 'SHLVL': '1', 07:09:47 INFO - 'TERM': 'linux', 07:09:47 INFO - 'TMOUT': '86400', 07:09:47 INFO - 'USER': 'cltbld', 07:09:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', 07:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:47 INFO - '_': '/tools/buildbot/bin/python'} 07:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:48 INFO - Running setup.py (path:/tmp/pip-Xj6Ywa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:48 INFO - Running setup.py (path:/tmp/pip-SuTKbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:48 INFO - Running setup.py (path:/tmp/pip-inC33w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:48 INFO - Running setup.py (path:/tmp/pip-IOxDd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:48 INFO - Running setup.py (path:/tmp/pip-FaiGVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:48 INFO - Running setup.py (path:/tmp/pip-1icWTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:48 INFO - Running setup.py (path:/tmp/pip-CnHL7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:48 INFO - Running setup.py (path:/tmp/pip-Iviuj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:48 INFO - Running setup.py (path:/tmp/pip-7rLx4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:48 INFO - Running setup.py (path:/tmp/pip-OGtKUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:48 INFO - Running setup.py (path:/tmp/pip-1yfbE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:48 INFO - Running setup.py (path:/tmp/pip-zmIp2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:49 INFO - Running setup.py (path:/tmp/pip-h4ucMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:49 INFO - Running setup.py (path:/tmp/pip-VI8qMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:49 INFO - Running setup.py (path:/tmp/pip-68Ybcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:49 INFO - Running setup.py (path:/tmp/pip-6PBJHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:49 INFO - Running setup.py (path:/tmp/pip-Cbi9Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:49 INFO - Running setup.py install for manifestparser 07:09:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:09:49 INFO - Running setup.py install for mozcrash 07:09:49 INFO - Running setup.py install for mozdebug 07:09:49 INFO - Running setup.py install for mozdevice 07:09:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:09:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:09:49 INFO - Running setup.py install for mozfile 07:09:49 INFO - Running setup.py install for mozhttpd 07:09:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:09:49 INFO - Running setup.py install for mozinfo 07:09:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:09:50 INFO - Running setup.py install for mozInstall 07:09:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:09:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:09:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:09:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:09:50 INFO - Running setup.py install for mozleak 07:09:50 INFO - Running setup.py install for mozlog 07:09:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:09:50 INFO - Running setup.py install for moznetwork 07:09:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:09:50 INFO - Running setup.py install for mozprocess 07:09:50 INFO - Running setup.py install for mozprofile 07:09:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:09:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:09:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:09:50 INFO - Running setup.py install for mozrunner 07:09:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:09:50 INFO - Running setup.py install for mozscreenshot 07:09:50 INFO - Running setup.py install for moztest 07:09:51 INFO - Running setup.py install for mozversion 07:09:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:09:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:51 INFO - Cleaning up... 07:09:51 INFO - Return code: 0 07:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:51 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 0x7f92649f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e160>, '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 0x104f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', '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 07:09:51 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 07:09:51 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 07:09:51 INFO - Using env: {'DISPLAY': ':0', 07:09:51 INFO - 'HOME': '/home/cltbld', 07:09:51 INFO - 'LANG': 'en_US.UTF-8', 07:09:51 INFO - 'LANGUAGE': 'en_US:en', 07:09:51 INFO - 'LOGNAME': 'cltbld', 07:09:51 INFO - 'MAIL': '/var/mail/cltbld', 07:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:51 INFO - 'MOZ_NO_REMOTE': '1', 07:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:51 INFO - 'NO_EM_RESTART': '1', 07:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:51 INFO - 'PWD': '/builds/slave/test', 07:09:51 INFO - 'SHELL': '/bin/bash', 07:09:51 INFO - 'SHLVL': '1', 07:09:51 INFO - 'TERM': 'linux', 07:09:51 INFO - 'TMOUT': '86400', 07:09:51 INFO - 'USER': 'cltbld', 07:09:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', 07:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:51 INFO - '_': '/tools/buildbot/bin/python'} 07:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:51 INFO - Running setup.py (path:/tmp/pip-yVlDQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:51 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)) 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:51 INFO - Running setup.py (path:/tmp/pip-Xkik8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:51 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)) 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:51 INFO - Running setup.py (path:/tmp/pip-XgqD3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:51 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)) 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:51 INFO - Running setup.py (path:/tmp/pip-4QfFtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:51 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)) 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:51 INFO - Running setup.py (path:/tmp/pip-lHJ3Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:51 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)) 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:51 INFO - Running setup.py (path:/tmp/pip-9k_KoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:51 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)) 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:51 INFO - Running setup.py (path:/tmp/pip-hgLUBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:51 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)) 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:51 INFO - Running setup.py (path:/tmp/pip-AsS19Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:51 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)) 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:51 INFO - Running setup.py (path:/tmp/pip-uTZCxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:51 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)) 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:52 INFO - Running setup.py (path:/tmp/pip-S813R1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:52 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)) 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:52 INFO - Running setup.py (path:/tmp/pip-U64mvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:52 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)) 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:52 INFO - Running setup.py (path:/tmp/pip-ol_FRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:52 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)) 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:52 INFO - Running setup.py (path:/tmp/pip-MG8cOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:52 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)) 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:52 INFO - Running setup.py (path:/tmp/pip-QOAmxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:52 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)) 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:52 INFO - Running setup.py (path:/tmp/pip-5_HXg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:52 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)) 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:52 INFO - Running setup.py (path:/tmp/pip-GLzuqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:52 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)) 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:52 INFO - Running setup.py (path:/tmp/pip-tqv2q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09:52 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 07:09:52 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 07:09:52 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 07:09:52 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 07:09:52 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 07:09:52 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 07:09:54 INFO - Downloading blessings-1.6.tar.gz 07:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:54 INFO - Installing collected packages: blessings 07:09:54 INFO - Running setup.py install for blessings 07:09:54 INFO - Successfully installed blessings 07:09:54 INFO - Cleaning up... 07:09:54 INFO - Return code: 0 07:09:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:54 INFO - Reading from file tmpfile_stdout 07:09:54 INFO - Current package versions: 07:09:54 INFO - argparse == 1.2.1 07:09:54 INFO - blessings == 1.6 07:09:54 INFO - blobuploader == 1.2.4 07:09:54 INFO - docopt == 0.6.1 07:09:54 INFO - manifestparser == 1.1 07:09:54 INFO - mozInstall == 1.12 07:09:54 INFO - mozcrash == 0.17 07:09:54 INFO - mozdebug == 0.1 07:09:54 INFO - mozdevice == 0.48 07:09:54 INFO - mozfile == 1.2 07:09:54 INFO - mozhttpd == 0.7 07:09:54 INFO - mozinfo == 0.9 07:09:54 INFO - mozleak == 0.1 07:09:54 INFO - mozlog == 3.1 07:09:54 INFO - moznetwork == 0.27 07:09:54 INFO - mozprocess == 0.22 07:09:54 INFO - mozprofile == 0.28 07:09:54 INFO - mozrunner == 6.11 07:09:54 INFO - mozscreenshot == 0.1 07:09:54 INFO - mozsystemmonitor == 0.0 07:09:54 INFO - moztest == 0.7 07:09:54 INFO - mozversion == 1.4 07:09:54 INFO - psutil == 3.1.1 07:09:54 INFO - requests == 1.2.3 07:09:54 INFO - wsgiref == 0.1.2 07:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:54 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 0x7f92649f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e160>, '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 0x104f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', '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 07:09:54 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 07:09:54 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 07:09:54 INFO - Using env: {'DISPLAY': ':0', 07:09:54 INFO - 'HOME': '/home/cltbld', 07:09:54 INFO - 'LANG': 'en_US.UTF-8', 07:09:54 INFO - 'LANGUAGE': 'en_US:en', 07:09:54 INFO - 'LOGNAME': 'cltbld', 07:09:54 INFO - 'MAIL': '/var/mail/cltbld', 07:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:54 INFO - 'MOZ_NO_REMOTE': '1', 07:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:54 INFO - 'NO_EM_RESTART': '1', 07:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:54 INFO - 'PWD': '/builds/slave/test', 07:09:54 INFO - 'SHELL': '/bin/bash', 07:09:54 INFO - 'SHLVL': '1', 07:09:54 INFO - 'TERM': 'linux', 07:09:54 INFO - 'TMOUT': '86400', 07:09:54 INFO - 'USER': 'cltbld', 07:09:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', 07:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:54 INFO - '_': '/tools/buildbot/bin/python'} 07:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:55 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)) 07:09:55 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)) 07:09:55 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)) 07:09:55 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)) 07:09:55 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)) 07:09:55 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)) 07:09:55 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)) 07:09:55 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)) 07:09:55 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)) 07:09:55 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)) 07:09:55 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)) 07:09:55 INFO - Cleaning up... 07:09:55 INFO - Return code: 0 07:09:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:55 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 0x7f92649f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e160>, '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 0x104f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', '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 07:09:55 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 07:09:55 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 07:09:55 INFO - Using env: {'DISPLAY': ':0', 07:09:55 INFO - 'HOME': '/home/cltbld', 07:09:55 INFO - 'LANG': 'en_US.UTF-8', 07:09:55 INFO - 'LANGUAGE': 'en_US:en', 07:09:55 INFO - 'LOGNAME': 'cltbld', 07:09:55 INFO - 'MAIL': '/var/mail/cltbld', 07:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:55 INFO - 'MOZ_NO_REMOTE': '1', 07:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:55 INFO - 'NO_EM_RESTART': '1', 07:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:55 INFO - 'PWD': '/builds/slave/test', 07:09:55 INFO - 'SHELL': '/bin/bash', 07:09:55 INFO - 'SHLVL': '1', 07:09:55 INFO - 'TERM': 'linux', 07:09:55 INFO - 'TMOUT': '86400', 07:09:55 INFO - 'USER': 'cltbld', 07:09:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', 07:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:55 INFO - '_': '/tools/buildbot/bin/python'} 07:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:55 INFO - Downloading/unpacking jsonschema 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:57 INFO - Downloading/unpacking functools32 (from jsonschema) 07:09:57 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 07:09:57 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 07:09:57 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 07:09:57 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 07:09:57 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 07:09:57 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 07:09:57 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:57 INFO - warning: no files found matching '*.txt' 07:09:57 INFO - no previously-included directories found matching 'build' 07:09:57 INFO - no previously-included directories found matching 'dist' 07:09:57 INFO - no previously-included directories found matching '.git*' 07:09:57 INFO - Installing collected packages: jsonschema, functools32 07:09:57 INFO - Running setup.py install for functools32 07:09:57 INFO - warning: no files found matching '*.txt' 07:09:57 INFO - no previously-included directories found matching 'build' 07:09:57 INFO - no previously-included directories found matching 'dist' 07:09:57 INFO - no previously-included directories found matching '.git*' 07:09:57 INFO - Successfully installed jsonschema functools32 07:09:57 INFO - Cleaning up... 07:09:57 INFO - Return code: 0 07:09:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:09:57 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')]} 07:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:57 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')]} 07:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:57 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 0x7f92649f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e160>, '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 0x104f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', '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 07:09:57 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 07:09:57 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 07:09:57 INFO - Using env: {'DISPLAY': ':0', 07:09:57 INFO - 'HOME': '/home/cltbld', 07:09:57 INFO - 'LANG': 'en_US.UTF-8', 07:09:57 INFO - 'LANGUAGE': 'en_US:en', 07:09:57 INFO - 'LOGNAME': 'cltbld', 07:09:57 INFO - 'MAIL': '/var/mail/cltbld', 07:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:57 INFO - 'MOZ_NO_REMOTE': '1', 07:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:57 INFO - 'NO_EM_RESTART': '1', 07:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:57 INFO - 'PWD': '/builds/slave/test', 07:09:57 INFO - 'SHELL': '/bin/bash', 07:09:57 INFO - 'SHLVL': '1', 07:09:57 INFO - 'TERM': 'linux', 07:09:57 INFO - 'TMOUT': '86400', 07:09:57 INFO - 'USER': 'cltbld', 07:09:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', 07:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:57 INFO - '_': '/tools/buildbot/bin/python'} 07:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:57 INFO - Downloading/unpacking flake8 07:09:57 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 07:09:57 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 07:09:57 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 07:09:57 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 07:09:57 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 07:09:57 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 07:09:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:09:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:10:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:10:00 INFO - no previously-included directories found matching 'docs/_build' 07:10:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:10:00 INFO - Running setup.py install for pep8 07:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:10:00 INFO - no previously-included directories found matching 'docs/_build' 07:10:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:10:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:10:00 INFO - Cleaning up... 07:10:00 INFO - Return code: 0 07:10:00 INFO - Running post-action listener: _resource_record_post_action 07:10:00 INFO - Running post-action listener: _start_resource_monitoring 07:10:00 INFO - Starting resource monitoring. 07:10:00 INFO - ##### 07:10:00 INFO - ##### Running install step. 07:10:00 INFO - ##### 07:10:00 INFO - Running pre-action listener: _resource_record_pre_action 07:10:00 INFO - Running main action method: install 07:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:01 INFO - Reading from file tmpfile_stdout 07:10:01 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:10:01 INFO - Reading from file tmpfile_stdout 07:10:01 INFO - Output received: 07:10:01 INFO - Usage: mozinstall [options] installer 07:10:01 INFO - Options: 07:10:01 INFO - -h, --help show this help message and exit 07:10:01 INFO - -d DEST, --destination=DEST 07:10:01 INFO - Directory to install application into. [default: 07:10:01 INFO - "/builds/slave/test"] 07:10:01 INFO - --app=APP Application being installed. [default: firefox] 07:10:01 INFO - mkdir: /builds/slave/test/build/application 07:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:10:16 INFO - Reading from file tmpfile_stdout 07:10:16 INFO - Output received: 07:10:16 INFO - /builds/slave/test/build/application/firefox/firefox 07:10:16 INFO - Running post-action listener: _resource_record_post_action 07:10:16 INFO - ##### 07:10:16 INFO - ##### Running run-tests step. 07:10:16 INFO - ##### 07:10:16 INFO - Running pre-action listener: _resource_record_pre_action 07:10:16 INFO - Running main action method: run_tests 07:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:10:16 INFO - Python 2.7.3 07:10:16 INFO - Return code: 0 07:10:16 INFO - grabbing minidump binary from tooltool 07:10:16 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')]} 07:10:16 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 0x104e160>, '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 0x104f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:10:16 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 07:10:16 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 07:10:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:10:16 INFO - Return code: 0 07:10:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:10:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:10:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:10:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:10:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:10:17 INFO - Return code: 0 07:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 07:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 07:10:17 INFO - Using env: {'DISPLAY': ':0', 07:10:17 INFO - 'HOME': '/home/cltbld', 07:10:17 INFO - 'LANG': 'en_US.UTF-8', 07:10:17 INFO - 'LANGUAGE': 'en_US:en', 07:10:17 INFO - 'LOGNAME': 'cltbld', 07:10:17 INFO - 'MAIL': '/var/mail/cltbld', 07:10:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:10:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:17 INFO - 'MOZ_NO_REMOTE': '1', 07:10:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:17 INFO - 'NO_EM_RESTART': '1', 07:10:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:17 INFO - 'PWD': '/builds/slave/test', 07:10:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:10:17 INFO - 'SHELL': '/bin/bash', 07:10:17 INFO - 'SHLVL': '1', 07:10:17 INFO - 'TERM': 'linux', 07:10:17 INFO - 'TMOUT': '86400', 07:10:17 INFO - 'USER': 'cltbld', 07:10:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572', 07:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:17 INFO - '_': '/tools/buildbot/bin/python'} 07:10:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 07:10:17 INFO - mozversion application_buildid: 20160627060238 07:10:17 INFO - mozversion application_changeset: 2fb323237cf5b1bab10bc0b5de80bca761607039 07:10:17 INFO - mozversion application_display_name: Nightly 07:10:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:17 INFO - mozversion application_name: Firefox 07:10:17 INFO - mozversion application_remotingname: firefox 07:10:17 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 07:10:17 INFO - mozversion application_vendor: Mozilla 07:10:17 INFO - mozversion application_version: 47.0.1 07:10:17 INFO - mozversion platform_buildid: 20160627060238 07:10:17 INFO - mozversion platform_changeset: 2fb323237cf5b1bab10bc0b5de80bca761607039 07:10:17 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 07:10:17 INFO - mozversion platform_version: 47.0.1 07:10:17 INFO - using testdate: 1467036617 07:10:17 INFO - actual date: 1467036617 07:10:17 INFO - starting webserver on 'localhost:33684' 07:10:17 INFO - SUITE-START | Running 2 tests 07:10:17 INFO - TEST-START | dromaeo_css 07:10:17 INFO - operating with platform_type : linux_ 07:10:17 INFO - Initialising browser for dromaeo_css test... 07:10:17 INFO - TEST-INFO | started process 31239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaTX7z9/profile http://localhost:33684/getInfo.html) 07:10:21 INFO - PROCESS | 31239 | __metrics Screen width/height:1600/1200 07:10:21 INFO - PROCESS | 31239 | colorDepth:24 07:10:21 INFO - PROCESS | 31239 | Browser inner width/height: 1024/697 07:10:21 INFO - PROCESS | 31239 | __metrics 07:10:22 INFO - PROCESS | 31239 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:23 INFO - TEST-INFO | 31239: exit 0 07:10:23 INFO - Browser initialized. 07:10:23 INFO - Running cycle 1/1 for dromaeo_css test... 07:10:23 INFO - TEST-INFO | started process 31332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaTX7z9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:35 INFO - PROCESS | 31332 | RSS: Main: 138625024 07:10:35 INFO - PROCESS | 31332 | 07:11:25 INFO - PROCESS | 31332 | 1467036685852 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] 07:13:37 INFO - PROCESS | 31332 | Cycle 1(1): loaded http://localhost:33684/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33684/tests/dromaeo/cssquery-ext.html) 07:13:37 INFO - PROCESS | 31332 | RSS: Main: 216420352 07:13:37 INFO - PROCESS | 31332 | 07:16:39 INFO - PROCESS | 31332 | Cycle 1(1): loaded http://localhost:33684/tests/dromaeo/cssquery-ext.html (next: http://localhost:33684/tests/dromaeo/cssquery-jquery.html) 07:16:40 INFO - PROCESS | 31332 | RSS: Main: 218402816 07:16:40 INFO - PROCESS | 31332 | 07:19:42 INFO - PROCESS | 31332 | Cycle 1(1): loaded http://localhost:33684/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33684/tests/dromaeo/cssquery-mootools.html) 07:19:42 INFO - PROCESS | 31332 | RSS: Main: 222273536 07:19:42 INFO - PROCESS | 31332 | 07:22:44 INFO - PROCESS | 31332 | Cycle 1(1): loaded http://localhost:33684/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33684/tests/dromaeo/cssquery-prototype.html) 07:22:45 INFO - PROCESS | 31332 | RSS: Main: 184676352 07:22:45 INFO - PROCESS | 31332 | 07:25:47 INFO - PROCESS | 31332 | Cycle 1(1): loaded http://localhost:33684/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33684/tests/dromaeo/cssquery-yui.html) 07:25:48 INFO - PROCESS | 31332 | RSS: Main: 187080704 07:25:48 INFO - PROCESS | 31332 | 07:28:50 INFO - PROCESS | 31332 | Cycle 1(1): loaded http://localhost:33684/tests/dromaeo/cssquery-yui.html (next: http://localhost:33684/tests/dromaeo/cssquery-dojo.html) 07:28:50 INFO - PROCESS | 31332 | RSS: Main: 240488448 07:28:50 INFO - PROCESS | 31332 | 07:28:50 INFO - PROCESS | 31332 | __start_tp_report 07:28:50 INFO - PROCESS | 31332 | _x_x_mozilla_page_load 07:28:50 INFO - PROCESS | 31332 | _x_x_mozilla_page_load_details 07:28:50 INFO - PROCESS | 31332 | |i|pagename|runs| 07:28:50 INFO - PROCESS | 31332 | |0;dojo.html;2781.7635500982415;2836.900708475203;2841.630588023557;2869.0245316592354;2881.4237152569476;4624.815007399704;4683.765811709418;4691.483936766957;4708;4708.811647534095;4671.22924717422;4686.859394218179;4701.717896926187;4704.482506924235;4725.480197178316;4167.062410957541;4233.1956928183545;4306.074194048279;4319.071399649075;4349.26062569364;4224.345226489883;4229.851955181569;4243.957560424403;4247.341662042389;4319.265724826787;4259.16946195492;4315.697901146921;4331.956680433187;4333.891652708676;4353.869383918472;4273.572642735733;4290.05618763873;4315.633171180453;4319.654427645781;4341.2836881914445;4111.773852438115;4223.535411104776;4272.060146767737;4324.070324880166;4324.805383757738;4556.8860778480475;4577.5880170784785;4594.19601569724;4616.6537509686905;4618.284165954283;4956.975215123901;4980.526849949285;4981.825636102755;4982.651214414992;5012.423571289312;4767.880802979918;4939.234418665113;4993.425756038066;5003.524665156804;5024.497550244982;4602.424696912853;4606.861794146181;4620.422447194101;4625.629949604024;4648.163330600524;4906.165951788204;5037.143685573388;5042.949570504321;5043.193089105725;5072.746362681851;4743.762811859393;4794.664373493822;4799.160146974265;4819.49395313494;4822.95177048225;4826.6621336506105;4867.488913664014;4873.902521949542;4889.804407823718;4914.410270767531;4692.483826779052;4788.281757736368;4796.856094317176;4800.207965685692;4837.105135549935;4870.780814863339;4908.288298196741;4932.038252540792;4942.678725882806;4950.43070046942;4183.518895327015;4186.790660466964;4192.329227323614;4212.957870421318;4212.978935105366;3669.8165091745304;3710.6289371062676;3725.1432170600374;3726.1616136369644;3755.7934313613014;4326.610605045561;4333.653307735437;4346.500152482442;4361.672874534359;4363.803628836647;4894.706317620954;4924.43369012561;4933.50664933511;4990.600751939909;5017.0216807722145;4210.2842516772225;4322.589354011364;4334.848280310174;4374.256376416017;4410.117976404667;4501;4501.459824821042;4511.8195272189405;4516.480604730498;4555.3850230218495;4795.6163506919365;4834.830780922721;4840.346553215341;4841.225403935354;4863.440704319049;4820.301056346881;4948.925766113583;4972.353594032753;5012.699238045729;5037.244413338029;4705.058988202305;4737.8341758038305;4747.667663263676;4754.191787396082;4775.904481910412;4853.514648535118;4865.464798872051;4865.6107511398295;4865.805367785249;4888.9755551222015;4792.9281060784815;4926.729029903389;4996.825111121093;5005.149124648746;5026.070177017264;4720.984988227548;4732.337472753886;4754.286856971482;4755.239161734106;4784.114938736345;4587.151376995266;4734.337192792943;4735.621150308036;4741.312509686008;4765.285207218945;4576.336431217522;4671.579557839811;4697;4745.525447455227;4784.545468180518;4832.420109586872;4851.078295123915;4855;4855.344528488608;4875.902481950412;4524.524924882971;4715.0805592909055;4719.716816990855;4720.055988802184;4723.031778485333 07:28:50 INFO - PROCESS | 31332 | |1;ext.html;510.84674597620705;534.2467121358883;566.8299510146954;567.6650776042136;585.1369230385183;28264.293392665193;35366.46950295744;36024.45963310552;36141.277174456496;36156;38591.80704096483;39121.413178802344;39139;39185.60814391855;39264.41103383445;7970.322522585573;8161.75514734556;8166.510009399455;8170.264676179143;8170.714025009126;8005.599720013976;8123.553204573746;8142.837143257131;8144.4298899077085;8349.624266907973;8317.126701696325;8397.286230670401;8412.03261624915;8437.70468033619;8440.240378365947;8305.584720763967;8391.370647201484;8399.37004724648;8400.705975290897;8401.327893768514;8190.140035296267;8325.500469971821;8326.875096873551;8327.541985190812;8329.08380078191;39297.80351098226;39729.40405893914;39816.40275395871;39820.402693959615;39846.60153398487;2716.7283271672673;2757.765589924859;2801.831890086601;2835.773138148943;2933.3839893622367;30449.695503045128;31070.53394199089;31076.844615776776;31179.50563954878;31265.374692506022;3057.8623961921767;3090.3355778507503;3091.4435401627698;3159.794613350125;3198.616166060064;231918;232019;232475;232826;233046;40520.594794052275;55741.72129139328;56469;56498.43501565014;56500.71749641225;43136.352954705704;43382.78308608437;43419.782901085295;43435.34846977235;43485.56514434879;12623.810642840364;12784.744305113845;12788.232706037668;12789.040821938206;12806.103572750004;9985.650502232387;10105.696829095139;10110;10112.241581881388;10116.645917392856;14489.130652160904;14541.41834326615;14541.709165816836;14544;14644.487442939446;5598.188262701886;5629.24005259293;5645.633033852787;5736.741846616912;5738.368779434259;951.8810148731409;1005.7686732051523;1009.7526106104051;1027.4811220333684;1029.464678367245;27429.45141097167;27824.721752782618;28597.57103643447;28610.427791444054;28804.42391152207;949.4493193947494;993.9155171810332;1018.6231094495084;1047.1831971062584;1048.816457120001;13301;13854.93072534651;13991.58025259244;14065.367058482392;14283.714325713427;354373;360885;362338;363267;363632;50613.493865060875;50635;51181.7440912793;51430.22854657183;51442.74278628583;1121.3832392184265;1177.7526719388852;1257.6792917805901;1294.326949986002;1329.8271224740722;25384.873075634503;27719.30701732473;27810;27920;27953.860230698716;41230.79384603058;41577.37633935433;41781.58218417777;41886.37170442385;41920.3711944315;217236;218771;219001;219201;219268;25823.741762582886;30234.54648180323;30889.845550773;31068.22329441782;31135.688643114187;36184.27631447409;39330.41004384994;39335.213295734495;39761.60238397695;39786.403203951384;32728.83635581902;32869.67130328666;32943.50584741183;33041.33917321688;33182;32907.17732056622;32929.176770580925;33010.66989330172;33068.66931330656;34109.82945085259;33467.33065338631;33864.322713546084;33959.32081358408;34127.4880876792;34362;29987.70012299849;30196.396072077994;30334.69665303319;30592.388152237276;30656;23504.41238968971;23874.761252387252;24157.63763543513;24278.757212428358;24399 07:28:50 INFO - PROCESS | 31332 | |2;jquery.html;350.43929712460067;354.67901549098076;355.4064711931075;355.46679980029955;355.95728512578495;16482.587935301624;16867.072311022905;16883.83116168838;17237.482875513724;17251.568710782205;13835.515756948509;14127.92936035321;14268.357923893424;14280.71438571228;14288.857111428882;4886.63350248731;4941.135301322272;5125.513076257749;5129.9227162295965;5139.8458046258675;3492.912677183065;4955.45489996102;5164.896702065976;5170.974145129269;5185.55922746567;5175.456577059411;5199.220116982445;5200.401953775307;5210.895782084356;5222.738863056851;5013.172826483626;5168.276441298202;5232.764525596357;5250.081235783741;5255.553277971377;5018.397792264952;5020.046191223692;5027.698338099689;5032.798688052473;5110.718910459923;11850.525978960832;12027.699307517294;12100.81848772269;12122.151449398458;12167.878321216764;1774.21047633803;1906.266087556287;1969.980300196994;1995.6152397884534;2416.2509622017233;8540.658373665108;9273.907260927439;10041.347312424741;11007.67907851055;12290.938545307306;1646.7529870519397;1762.8237176282398;1767.45435817821;1783.8929664220188;1794.6231291428685;56506;56985;57023.714881425745;57564.424355756324;58634;9330.766730831783;9435.622575097057;9601.087896649948;9645.08371704687;9712.562934667956;12906.870931290567;12964.870351296555;12983.545575904798;12983.805242921364;13007.219566826021;6636.601803891782;6744.22441419243;6778.084958530634;6850.794476165624;6862.073620061327;6275.843103922439;6303.6532990685955;6365.204349456318;6383.585066970632;6411.839704007344;4152.501699796044;4168.937465938014;4234.915301693949;4237.364395340662;4263.786810659454;1544.7065057639013;1571.834957329464;1608.3807734022253;1694;1756.7628370170119;837.656560810065;878.7759121423996;960.9135177834029;977.5698692575244;977.5747549815853;15068.924655376872;15195.544133676007;15573.610659733371;15633.765493517607;15739.606509837346;900.4102312985005;911.289194428347;932.2495391210141;949.520492151459;982.2142286171035;8939.061398553058;9158.40470369424;9297.256219502424;9381.859272110923;9426.387284826602;407594;414621;418146;425764;436206;68564.31435685679;70555.2944470559;70760.2923970764;71550.28449715437;72828.63585682143;943.1605870775015;951.2342564235719;966.3184662561448;968.7287559483356;972.4700038479045;14468.493602723855;14559.563213103624;14620;14711.779323310373;14853;30651.386972260876;31284.37431251408;32392;32550.83724581362;32937.17657058497;45868.54131458776;46477.767611161726;46611;46798;46817.06365872595;7395.519291246052;7410.96294518524;7418;7652.158262591;7661.961690191513;9998.750031249278;11574.942125289657;11664.183507154417;11676.532938682698;11881.881181188077;9539.902911165027;9692.612295508101;9748.512574371394;10142.746431339276;10145.34055286404;9693.27300452483;9858.211343092678;10085.899141008496;10169.338992965433;10281.074703276741;9956.701298961043;10122.696319110439;10207.591696332063;10243.590256389662;10507.159427245955;7377.3360397564475;7478.588677622783;7486.5508069516;7487.438442116972;7557.5465472071855;8638.697645582375;9956.452395118338;10066.8489972649;10100.848487272844;10401.427921464392 07:28:50 INFO - PROCESS | 31332 | |3;mootools.html;1288.7164823738774;1443.1918125849525;1459.7737350710643;1632.4368093007915;1842.530154810523;7413.295736904992;7590.3548198403205;7597.31624153826;7600.429967752413;7608.505447145932;7486.213947535499;7629.618519074052;7636.083669959598;7642.04474440695;7644.273793989576;2159.427751645815;2181.4655409424713;2184.9344519664437;2185.5519618478174;2185.67214917762;2206.3160420269687;2231.7991380775725;2286.748457669655;2289.69089172962;2293.8508996915148;2193.056985496244;2209.635410157322;2213.4134454369605;2214.3910424633273;2239.2386588559884;2166.729158855143;2176.5320456101936;2189.3322536626324;2192.0683709423593;2193.56128774245;2242.0471299697565;2245.786650268222;2257.920972765962;2258.446680563256;2264.060414927803;7740.845183096363;7776.961115194445;7784.494007889469;7784.844303113962;7804.687812487494;4240.872773816791;4368.017196130877;4368.847090351823;4388.407564978719;4392.450943632046;2702.6891907430504;2872;2887.5524293734507;2904.0852131578695;2911.898083567065;844.2317491083085;870.5342641686731;878.83302172587;884.9955750221208;889.3996552327153;10653.201009924287;10729;10737.302075365076;10756.139508839275;10759.139268858473;4062.898427539276;4172.624463798273;4193.5387107418155;4196.097838964637;4260.382244574519;9157.862632060524;9195.494247816434;9197.448153110834;9208.033156518602;9236.8614470783;4433.889152771142;4438.423005009328;4441.933370999438;4442.511323754385;4451.554844515523;3319.054069590155;3783.375743002374;3931.292367373843;3991.102002049574;4028.576999415019;3509.754317197772;3562.287542491512;3588.3361578108133;3606.6753992140307;3615.475756015363;1158.9942050289694;1166.311875993168;1175.2126075529416;1178.622840690988;1180.4392913366255;1218.2020776391478;1224.1064023263068;1232.353014667289;1233.2600439736086;1254.0406588959454;7241.710331586783;7268.309510596485;7297.781066568012;7411.295926886937;7449.44129190302;451.7334772484184;460.4198709625829;464.9418822647169;465.862570541691;466.0422831082159;5380.78476860929;5386.811461598825;5387.111126664135;5393.487618676298;5415.647982881179;9039.09609039104;9271.304652151115;9546.474943878153;9557.378770379903;9588.424694518351;9292.303077269233;9295.814083718424;9299;9318.580663870142;9336.206422454032;6770.492213084039;6978.162620485574;6978.197507286625;6995.510314277952;7113.110861142357;7094.077769889881;7094.858102837811;7096.680649370894;7117.181524124792;7165.3551180394015;8108.2297181767635;8299.751007469786;8317.168283171635;8322.250997410261;8358.414910956175;8316.83366332682;8504;8512.829743405222;8639.04970453237;8651.567421629019;6186.443220110032;6292.811215663354;6365;6373.840653983688;6403.519736019724;6992.755253566101;7001.474889383215;7038.859222815618;7047.08387909589;7065.258147894603;6286.622802631674;6468.773592924225;6520.641364724986;6533.575317604341;6599.175103112111;6079.726412311545;6175.59858609189;6214.8135555933395;6260.780872669435;6357.96821015892;6757.662116894234;6776.220734615582;6804.353586409283;6815.89776153368;6823.351781580742;6053.848653783691;6071.392860713893;6083.178770865877;6095.847603809941;6130.785422510191;6120.7551697931585;6145.938540614537;6172.629642221481;6174.598651087665;6194.752209911553 07:28:50 INFO - PROCESS | 31332 | |4;prototype.html;326.5232760170152;332.2607198982264;332.7354752971389;335.7247057412922;339.8810416354275;5391.595630327722;5432.782688692452;5439.809606663767;5447.591430642703;5448.673079615226;5327.041132596131;5329.680219186852;5330.813421530247;5332.57339412847;5395.136778115502;4048.109415928491;4132.566080561543;4199.9580004200025;4278.229918614656;4304.935425968613;4272.252355837732;4280.443542339492;4282.03654177809;4296.48442186938;4302.849400270991;4249.213895429355;4261.2329780639475;4262.211490874182;4262.531121576624;4271.295236286009;4021.9597804022023;4116.300228961084;4178.435911152016;4196.181744559812;4219.7046206765535;3770.076331298822;3772.7170462215445;3777.1690228149764;3780.9054773630605;3782.8865134046023;5240.449752775941;5251.711155886424;5260.763265653055;5262.315898933152;5267.552258058031;4894.339264199323;4896.46138924718;4902.8774280643265;4908.190148625473;4918.188498897677;5696.943030569682;5710.943475457054;5713.171590119451;5718.228039214736;5724.39893811148;3865.903352416184;4129.793510324472;4137.668986481074;4138.875833724993;4143.067809742814;5850.122481627747;5951.047832346804;5986.610870293461;5993.430624090748;6014.699265036731;4114.177164567039;4119.855805046809;4119.876403707894;4127.153933443637;4129.97935010323;4188.183304255702;4188.790560471964;4193.748375097504;4196.139791342767;4196.91606167881;4793.688410253322;4798;4807.567318941312;4810.807567697323;4812.614990800797;5717.342505611825;5728.627639203439;5730.255066841284;5733.254676891977;5733.73517460609;1423.6227399739078;1461.3277892169508;1469.7648376259747;1481.029925398844;1484.6511069898565;928.8838895138108;941.4868896451451;970.6505657963128;987.9654212102541;989.0455710239653;5047.343845300161;5110.4634013428795;5136.871578210575;5148.897022059537;5158.071547121554;6019.307779605401;6030.638161710223;6060.787872424444;6097.512199024068;6099.420555047263;5180.585553155738;5184.222366645034;5185.688858668492;5185.818496352609;5189.948100519022;3187.123541026236;3225.3710526447117;3227.386796508656;3231.4829627259523;3232.321212545392;5613;5759.337676167294;5764.106563482667;5766.4233576642;5767.250257466502;6135.785247516315;6137.171481849893;6144.539159563051;6146.846328841725;6155.630662160284;5719.456651618089;5736.541076713853;5744.856378590569;5751.1085781703905;5759.193712880284;5984.9401505986125;5986.491148252273;5996.790112346047;5999.4900433463645;6003.6998150093195;5849.473547380756;5852.795152169653;5858.355580886185;5865.090910908816;5868.911966320423;5577.609567330248;5708.80019199326;5734.799282025109;5741.569382296261;5757.222774925332;4133.772642504691;4156.9792151040265;4158.147579746205;4164.000639846355;4165.833366665421;5972.044472884318;5976.043832986701;5977.462028417463;6018.578699490994;6065.696715164136;5725.370209277059;5773.595848290579;5774.105013722879;5775.566832487664;5779.450952159538;5744.425557444222;5757.280339957505;5760.251167348218;5764.221830052889;5777.711114444345;5493.587980901529;5648.943510564842;5655.547556195576;5661.320641523043;5671.546276297969;5791.420857914175;5809.302883653989;5810.82567522975;5817.94182058174;5822.7670893163795;5623.803166889139;5625.212470254086;5628.774849005994;5636.5208957237455;5639.154126881001 07:28:50 INFO - PROCESS | 31332 | |5;yui.html;644.9226092868855;656.7176114270864;662.6752891083368;666.7499687617144;687.1925487552126;11295.887041129587;11406.372649504274;11422.14333924957;11506.42467876606;11534.192606517547;10825.621103261368;10895.83656245157;10965.232433729621;10978.560857565688;10986.890131098686;683.6171743823475;830.0495932157676;837.1126605797858;852.2031900173358;862.3015357560396;852.2968550945495;859.8667206582959;861.2808305065247;862.1550880137469;862.7972426479772;905.0903841639143;905.8369493491169;905.868649045888;905.9229965452945;906.1618003346911;724.9492535522515;870.8911386076741;887.6626881784945;888.3337496877342;900.5002223765807;659.6932426421689;661.5369241530948;662.2384258103172;662.529603981174;662.9270780214221;10133.189344852393;10192.74518137045;10212.080912717816;10247.897521024768;10302.278840481169;11281.32312061279;11619.453248811427;12429.192102513307;12645.92509636682;12665.493380264777;8307.08622051574;8358.113795868801;8523.659053637846;8542.103079176659;8577.957110214471;3289.1283809790425;3323.252268239651;3336.1492819331156;3372.426687463137;3393.389189945809;40042.199156017006;40331.59668403308;40602.390964135564;41549;41591.999999999694;9793.118619324296;9850.950745246228;9890.901090988998;9920.057594528509;9930.304878658424;16965.575860603338;17113.828861711474;17128.91435542839;17181.656366872594;17565.912170439322;6366.204224471941;6460.257070436866;6479.254885688206;6486.740530378826;6504.772332968323;3584.713222942158;3588.1926566522325;3605.603383627799;3629.292288003814;3703.9074023149637;2692.9730702693114;2707.039001154601;2707.160780158118;2710.9728902711113;2731.440054788803;507.6142131979722;514.1952843799442;518.0002594991702;520.5731300333765;525.7450136683706;434.6978849699492;436.8427366148184;510.6859281541825;540.5513423858188;549.8240563019796;6961.895571566431;7202.855942881218;7251.311125443074;7303.817404564928;7360.668769905367;435.4904761429072;460.4612603254201;485.9708417494962;494.7377889718455;509.7909856958629;3300.290437555937;3314.834258287076;3317.93364132716;3398.932021359559;3473.4789781532468;47834.521654783704;50814.49185508172;50819.74590127026;50902.23646645303;50917;45803.3129503051;46194.76902615465;46665;46831.76584117058;46996.7650161747;41025;41093.58906410898;41213.79393103015;41296.587034129276;41398.37902431466;6665.300143484864;6716.059751634677;6756.729730810713;6775.390214880685;6857.5199736018;32080.35839283248;32541.511877322333;32696;32760.344793104483;33169.336613267114;39647.40528892011;40924.18151636891;41386.58613413948;41458.58541414547;41527.58472415358;7875.133735288999;8127.268545830903;8391.244787969112;8432.578371081545;8476.321894248322;8783.91216087831;8923.776905577413;9039.728808135766;9062.04848490899;9152.95423522878;8200.138985406445;8310.044344900172;8545.786355340917;8553.401261911606;8566.700165494178;8584.141585841366;8633.568321584022;8695.391322607356;8797.868031979653;8804.86792698123;8431.747047588582;8462.11147829469;8619.6983105591;8651.567421629019;8652.697155599524;7094.11323584552;7356.4114870809135;7416.96291518539;7443.888341674771;7454.850902982019;7153.319582698138;7169.318914703304;7331.120265568166;7344.853102938018;7431.962840185764 07:28:50 INFO - PROCESS | 31332 | __end_tp_report 07:28:50 INFO - PROCESS | 31332 | __start_cc_report 07:28:50 INFO - PROCESS | 31332 | _x_x_mozilla_cycle_collect,763 07:28:50 INFO - PROCESS | 31332 | __end_cc_report 07:28:50 INFO - PROCESS | 31332 | __startTimestamp1467037730764__endTimestamp 07:28:50 INFO - PROCESS | 31332 | 07:28:50 INFO - PROCESS | 31332 | ------- Summary: start ------- 07:28:50 INFO - PROCESS | 31332 | Number of tests: 6 07:28:50 INFO - PROCESS | 31332 | 07:28:50 INFO - PROCESS | 31332 | [#0] dojo.html Cycles:165 Average:4584.07 Median:4719.72 stddev:431.16 (9.1%) stddev-sans-first:408.64 07:28:50 INFO - PROCESS | 31332 | Values: 2781.8 2836.9 2841.6 2869.0 2881.4 4624.8 4683.8 4691.5 4708.0 4708.8 4671.2 4686.9 4701.7 4704.5 4725.5 4167.1 4233.2 4306.1 4319.1 4349.3 4224.3 4229.9 4244.0 4247.3 4319.3 4259.2 4315.7 4332.0 4333.9 4353.9 4273.6 4290.1 4315.6 4319.7 4341.3 4111.8 4223.5 4272.1 4324.1 4324.8 4556.9 4577.6 4594.2 4616.7 4618.3 4957.0 4980.5 4981.8 4982.7 5012.4 4767.9 4939.2 4993.4 5003.5 5024.5 4602.4 4606.9 4620.4 4625.6 4648.2 4906.2 5037.1 5042.9 5043.2 5072.7 4743.8 4794.7 4799.2 4819.5 4823.0 4826.7 4867.5 4873.9 4889.8 4914.4 4692.5 4788.3 4796.9 4800.2 4837.1 4870.8 4908.3 4932.0 4942.7 4950.4 4183.5 4186.8 4192.3 4213.0 4213.0 3669.8 3710.6 3725.1 3726.2 3755.8 4326.6 4333.7 4346.5 4361.7 4363.8 4894.7 4924.4 4933.5 4990.6 5017.0 4210.3 4322.6 4334.8 4374.3 4410.1 4501.0 4501.5 4511.8 4516.5 4555.4 4795.6 4834.8 4840.3 4841.2 4863.4 4820.3 4948.9 4972.4 5012.7 5037.2 4705.1 4737.8 4747.7 4754.2 4775.9 4853.5 4865.5 4865.6 4865.8 4889.0 4792.9 4926.7 4996.8 5005.1 5026.1 4721.0 4732.3 4754.3 4755.2 4784.1 4587.2 4734.3 4735.6 4741.3 4765.3 4576.3 4671.6 4697.0 4745.5 4784.5 4832.4 4851.1 4855.0 4855.3 4875.9 4524.5 4715.1 4719.7 4720.1 4723.0 07:28:50 INFO - PROCESS | 31332 | 07:28:50 INFO - PROCESS | 31332 | [#1] ext.html Cycles:180 Average:42565.65 Median:33324.67 stddev:73062.77 (219.2%) stddev-sans-first:73199.50 07:28:50 INFO - PROCESS | 31332 | Values: 510.8 534.2 566.8 567.7 585.1 28264.3 35366.5 36024.5 36141.3 36156.0 38591.8 39121.4 39139.0 39185.6 39264.4 7970.3 8161.8 8166.5 8170.3 8170.7 8005.6 8123.6 8142.8 8144.4 8349.6 8317.1 8397.3 8412.0 8437.7 8440.2 8305.6 8391.4 8399.4 8400.7 8401.3 8190.1 8325.5 8326.9 8327.5 8329.1 39297.8 39729.4 39816.4 39820.4 39846.6 2716.7 2757.8 2801.8 2835.8 2933.4 30449.7 31070.5 31076.8 31179.5 31265.4 3057.9 3090.3 3091.4 3159.8 3198.6 231918.0 232019.0 232475.0 232826.0 233046.0 40520.6 55741.7 56469.0 56498.4 56500.7 43136.4 43382.8 43419.8 43435.3 43485.6 12623.8 12784.7 12788.2 12789.0 12806.1 9985.7 10105.7 10110.0 10112.2 10116.6 14489.1 14541.4 14541.7 14544.0 14644.5 5598.2 5629.2 5645.6 5736.7 5738.4 951.9 1005.8 1009.8 1027.5 1029.5 27429.5 27824.7 28597.6 28610.4 28804.4 949.4 993.9 1018.6 1047.2 1048.8 13301.0 13854.9 13991.6 14065.4 14283.7 354373.0 360885.0 362338.0 363267.0 363632.0 50613.5 50635.0 51181.7 51430.2 51442.7 1121.4 1177.8 1257.7 1294.3 1329.8 25384.9 27719.3 27810.0 27920.0 27953.9 41230.8 41577.4 41781.6 41886.4 41920.4 217236.0 218771.0 219001.0 219201.0 219268.0 25823.7 30234.5 30889.8 31068.2 31135.7 36184.3 39330.4 39335.2 39761.6 39786.4 32728.8 32869.7 32943.5 33041.3 33182.0 32907.2 32929.2 33010.7 33068.7 34109.8 33467.3 33864.3 33959.3 34127.5 34362.0 29987.7 30196.4 30334.7 30592.4 30656.0 23504.4 23874.8 24157.6 24278.8 24399.0 07:28:50 INFO - PROCESS | 31332 | 07:28:50 INFO - PROCESS | 31332 | [#2] jquery.html Cycles:180 Average:23883.30 Median:4913.88 stddev:68965.32 (1403.5%) stddev-sans-first:69136.15 07:28:50 INFO - PROCESS | 31332 | Values: 350.4 354.7 355.4 355.5 356.0 16482.6 16867.1 16883.8 17237.5 17251.6 13835.5 14127.9 14268.4 14280.7 14288.9 4886.6 4941.1 5125.5 5129.9 5139.8 3492.9 4955.5 5164.9 5171.0 5185.6 5175.5 5199.2 5200.4 5210.9 5222.7 5013.2 5168.3 5232.8 5250.1 5255.6 5018.4 5020.0 5027.7 5032.8 5110.7 11850.5 12027.7 12100.8 12122.2 12167.9 1774.2 1906.3 1970.0 1995.6 2416.3 8540.7 9273.9 10041.3 11007.7 12290.9 1646.8 1762.8 1767.5 1783.9 1794.6 56506.0 56985.0 57023.7 57564.4 58634.0 9330.8 9435.6 9601.1 9645.1 9712.6 12906.9 12964.9 12983.5 12983.8 13007.2 6636.6 6744.2 6778.1 6850.8 6862.1 6275.8 6303.7 6365.2 6383.6 6411.8 4152.5 4168.9 4234.9 4237.4 4263.8 1544.7 1571.8 1608.4 1694.0 1756.8 837.7 878.8 960.9 977.6 977.6 15068.9 15195.5 15573.6 15633.8 15739.6 900.4 911.3 932.2 949.5 982.2 8939.1 9158.4 9297.3 9381.9 9426.4 407594.0 414621.0 418146.0 425764.0 436206.0 68564.3 70555.3 70760.3 71550.3 72828.6 943.2 951.2 966.3 968.7 972.5 14468.5 14559.6 14620.0 14711.8 14853.0 30651.4 31284.4 32392.0 32550.8 32937.2 45868.5 46477.8 46611.0 46798.0 46817.1 7395.5 7411.0 7418.0 7652.2 7662.0 9998.8 11574.9 11664.2 11676.5 11881.9 9539.9 9692.6 9748.5 10142.7 10145.3 9693.3 9858.2 10085.9 10169.3 10281.1 9956.7 10122.7 10207.6 10243.6 10507.2 7377.3 7478.6 7486.6 7487.4 7557.5 8638.7 9956.5 10066.8 10100.8 10401.4 07:28:50 INFO - PROCESS | 31332 | 07:28:50 INFO - PROCESS | 31332 | [#3] mootools.html Cycles:180 Average:5274.23 Median:6125.77 stddev:2826.66 (46.1%) stddev-sans-first:2818.72 07:28:50 INFO - PROCESS | 31332 | Values: 1288.7 1443.2 1459.8 1632.4 1842.5 7413.3 7590.4 7597.3 7600.4 7608.5 7486.2 7629.6 7636.1 7642.0 7644.3 2159.4 2181.5 2184.9 2185.6 2185.7 2206.3 2231.8 2286.7 2289.7 2293.9 2193.1 2209.6 2213.4 2214.4 2239.2 2166.7 2176.5 2189.3 2192.1 2193.6 2242.0 2245.8 2257.9 2258.4 2264.1 7740.8 7777.0 7784.5 7784.8 7804.7 4240.9 4368.0 4368.8 4388.4 4392.5 2702.7 2872.0 2887.6 2904.1 2911.9 844.2 870.5 878.8 885.0 889.4 10653.2 10729.0 10737.3 10756.1 10759.1 4062.9 4172.6 4193.5 4196.1 4260.4 9157.9 9195.5 9197.4 9208.0 9236.9 4433.9 4438.4 4441.9 4442.5 4451.6 3319.1 3783.4 3931.3 3991.1 4028.6 3509.8 3562.3 3588.3 3606.7 3615.5 1159.0 1166.3 1175.2 1178.6 1180.4 1218.2 1224.1 1232.4 1233.3 1254.0 7241.7 7268.3 7297.8 7411.3 7449.4 451.7 460.4 464.9 465.9 466.0 5380.8 5386.8 5387.1 5393.5 5415.6 9039.1 9271.3 9546.5 9557.4 9588.4 9292.3 9295.8 9299.0 9318.6 9336.2 6770.5 6978.2 6978.2 6995.5 7113.1 7094.1 7094.9 7096.7 7117.2 7165.4 8108.2 8299.8 8317.2 8322.3 8358.4 8316.8 8504.0 8512.8 8639.0 8651.6 6186.4 6292.8 6365.0 6373.8 6403.5 6992.8 7001.5 7038.9 7047.1 7065.3 6286.6 6468.8 6520.6 6533.6 6599.2 6079.7 6175.6 6214.8 6260.8 6358.0 6757.7 6776.2 6804.4 6815.9 6823.4 6053.8 6071.4 6083.2 6095.8 6130.8 6120.8 6145.9 6172.6 6174.6 6194.8 07:28:50 INFO - PROCESS | 31332 | 07:28:50 INFO - PROCESS | 31332 | [#4] prototype.html Cycles:180 Average:4791.13 Median:5413.96 stddev:1407.40 (26.0%) stddev-sans-first:1370.87 07:28:50 INFO - PROCESS | 31332 | Values: 326.5 332.3 332.7 335.7 339.9 5391.6 5432.8 5439.8 5447.6 5448.7 5327.0 5329.7 5330.8 5332.6 5395.1 4048.1 4132.6 4200.0 4278.2 4304.9 4272.3 4280.4 4282.0 4296.5 4302.8 4249.2 4261.2 4262.2 4262.5 4271.3 4022.0 4116.3 4178.4 4196.2 4219.7 3770.1 3772.7 3777.2 3780.9 3782.9 5240.4 5251.7 5260.8 5262.3 5267.6 4894.3 4896.5 4902.9 4908.2 4918.2 5696.9 5710.9 5713.2 5718.2 5724.4 3865.9 4129.8 4137.7 4138.9 4143.1 5850.1 5951.0 5986.6 5993.4 6014.7 4114.2 4119.9 4119.9 4127.2 4130.0 4188.2 4188.8 4193.7 4196.1 4196.9 4793.7 4798.0 4807.6 4810.8 4812.6 5717.3 5728.6 5730.3 5733.3 5733.7 1423.6 1461.3 1469.8 1481.0 1484.7 928.9 941.5 970.7 988.0 989.0 5047.3 5110.5 5136.9 5148.9 5158.1 6019.3 6030.6 6060.8 6097.5 6099.4 5180.6 5184.2 5185.7 5185.8 5189.9 3187.1 3225.4 3227.4 3231.5 3232.3 5613.0 5759.3 5764.1 5766.4 5767.3 6135.8 6137.2 6144.5 6146.8 6155.6 5719.5 5736.5 5744.9 5751.1 5759.2 5984.9 5986.5 5996.8 5999.5 6003.7 5849.5 5852.8 5858.4 5865.1 5868.9 5577.6 5708.8 5734.8 5741.6 5757.2 4133.8 4157.0 4158.1 4164.0 4165.8 5972.0 5976.0 5977.5 6018.6 6065.7 5725.4 5773.6 5774.1 5775.6 5779.5 5744.4 5757.3 5760.3 5764.2 5777.7 5493.6 5648.9 5655.5 5661.3 5671.5 5791.4 5809.3 5810.8 5817.9 5822.8 5623.8 5625.2 5628.8 5636.5 5639.2 07:28:50 INFO - PROCESS | 31332 | 07:28:50 INFO - PROCESS | 31332 | [#5] yui.html Cycles:180 Average:11943.62 Median:3505.56 stddev:14275.92 (407.2%) stddev-sans-first:14290.75 07:28:50 INFO - PROCESS | 31332 | Values: 644.9 656.7 662.7 666.7 687.2 11295.9 11406.4 11422.1 11506.4 11534.2 10825.6 10895.8 10965.2 10978.6 10986.9 683.6 830.0 837.1 852.2 862.3 852.3 859.9 861.3 862.2 862.8 905.1 905.8 905.9 905.9 906.2 724.9 870.9 887.7 888.3 900.5 659.7 661.5 662.2 662.5 662.9 10133.2 10192.7 10212.1 10247.9 10302.3 11281.3 11619.5 12429.2 12645.9 12665.5 8307.1 8358.1 8523.7 8542.1 8578.0 3289.1 3323.3 3336.1 3372.4 3393.4 40042.2 40331.6 40602.4 41549.0 41592.0 9793.1 9851.0 9890.9 9920.1 9930.3 16965.6 17113.8 17128.9 17181.7 17565.9 6366.2 6460.3 6479.3 6486.7 6504.8 3584.7 3588.2 3605.6 3629.3 3703.9 2693.0 2707.0 2707.2 2711.0 2731.4 507.6 514.2 518.0 520.6 525.7 434.7 436.8 510.7 540.6 549.8 6961.9 7202.9 7251.3 7303.8 7360.7 435.5 460.5 486.0 494.7 509.8 3300.3 3314.8 3317.9 3398.9 3473.5 47834.5 50814.5 50819.7 50902.2 50917.0 45803.3 46194.8 46665.0 46831.8 46996.8 41025.0 41093.6 41213.8 41296.6 41398.4 6665.3 6716.1 6756.7 6775.4 6857.5 32080.4 32541.5 32696.0 32760.3 33169.3 39647.4 40924.2 41386.6 41458.6 41527.6 7875.1 8127.3 8391.2 8432.6 8476.3 8783.9 8923.8 9039.7 9062.0 9153.0 8200.1 8310.0 8545.8 8553.4 8566.7 8584.1 8633.6 8695.4 8797.9 8804.9 8431.7 8462.1 8619.7 8651.6 8652.7 7094.1 7356.4 7417.0 7443.9 7454.9 7153.3 7169.3 7331.1 7344.9 7432.0 07:28:50 INFO - PROCESS | 31332 | -------- Summary: end -------- 07:28:50 INFO - PROCESS | 31332 | 07:28:51 INFO - TEST-INFO | 31332: exit 0 07:28:51 INFO - TEST-OK | dromaeo_css | took 1114108ms 07:28:51 INFO - TEST-START | kraken 07:28:51 INFO - operating with platform_type : linux_ 07:28:51 INFO - Initialising browser for kraken test... 07:28:51 INFO - TEST-INFO | started process 31523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoHoBmn/profile http://localhost:33684/getInfo.html) 07:28:55 INFO - PROCESS | 31523 | __metrics Screen width/height:1600/1200 07:28:55 INFO - PROCESS | 31523 | colorDepth:24 07:28:55 INFO - PROCESS | 31523 | Browser inner width/height: 1024/697 07:28:55 INFO - PROCESS | 31523 | __metrics 07:28:56 INFO - PROCESS | 31523 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:28:57 INFO - TEST-INFO | 31523: exit 0 07:28:57 INFO - Browser initialized. 07:28:57 INFO - Running cycle 1/1 for kraken test... 07:28:57 INFO - TEST-INFO | started process 31611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoHoBmn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:09 INFO - PROCESS | 31611 | RSS: Main: 139272192 07:29:09 INFO - PROCESS | 31611 | 07:29:11 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33684/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:12 INFO - PROCESS | 31611 | RSS: Main: 182792192 07:29:12 INFO - PROCESS | 31611 | 07:29:14 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33684/tests/kraken/driver.html?testName=audio-dft) 07:29:15 INFO - PROCESS | 31611 | RSS: Main: 174600192 07:29:15 INFO - PROCESS | 31611 | 07:29:18 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33684/tests/kraken/driver.html?testName=audio-fft) 07:29:18 INFO - PROCESS | 31611 | RSS: Main: 175771648 07:29:18 INFO - PROCESS | 31611 | 07:29:21 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33684/tests/kraken/driver.html?testName=audio-oscillator) 07:29:21 INFO - PROCESS | 31611 | RSS: Main: 175869952 07:29:21 INFO - PROCESS | 31611 | 07:29:23 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33684/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:29:24 INFO - PROCESS | 31611 | RSS: Main: 174477312 07:29:24 INFO - PROCESS | 31611 | 07:29:27 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33684/tests/kraken/driver.html?testName=imaging-darkroom) 07:29:28 INFO - PROCESS | 31611 | RSS: Main: 173809664 07:29:28 INFO - PROCESS | 31611 | 07:29:31 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33684/tests/kraken/driver.html?testName=imaging-desaturate) 07:29:32 INFO - PROCESS | 31611 | RSS: Main: 174338048 07:29:32 INFO - PROCESS | 31611 | 07:29:34 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33684/tests/kraken/driver.html?testName=json-parse-financial) 07:29:35 INFO - PROCESS | 31611 | RSS: Main: 174678016 07:29:35 INFO - PROCESS | 31611 | 07:29:37 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33684/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:29:37 INFO - PROCESS | 31611 | RSS: Main: 182226944 07:29:37 INFO - PROCESS | 31611 | 07:29:39 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33684/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:29:40 INFO - PROCESS | 31611 | RSS: Main: 181395456 07:29:40 INFO - PROCESS | 31611 | 07:29:42 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33684/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:29:42 INFO - PROCESS | 31611 | RSS: Main: 184025088 07:29:42 INFO - PROCESS | 31611 | 07:29:45 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:45 INFO - PROCESS | 31611 | RSS: Main: 187944960 07:29:45 INFO - PROCESS | 31611 | 07:29:48 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:48 INFO - PROCESS | 31611 | RSS: Main: 186126336 07:29:48 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | Cycle 1(1): loaded http://localhost:33684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33684/tests/kraken/driver.html?testName=ai-astar) 07:29:50 INFO - PROCESS | 31611 | RSS: Main: 248147968 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | __start_tp_report 07:29:50 INFO - PROCESS | 31611 | _x_x_mozilla_page_load 07:29:50 INFO - PROCESS | 31611 | _x_x_mozilla_page_load_details 07:29:50 INFO - PROCESS | 31611 | |i|pagename|runs| 07:29:50 INFO - PROCESS | 31611 | |0;ai-astar;114;113;114;114;115;114;114;115;113;127 07:29:50 INFO - PROCESS | 31611 | |1;audio-beat-detection;158;132;156;177;133;157;160;134;175;133 07:29:50 INFO - PROCESS | 31611 | |2;audio-dft;163;162;163;162;162;162;161;162;161;162 07:29:50 INFO - PROCESS | 31611 | |3;audio-fft;73;76;74;156;77;74;76;77;162;75 07:29:50 INFO - PROCESS | 31611 | |4;audio-oscillator;94;94;134;94;95;94;136;98;96;140 07:29:50 INFO - PROCESS | 31611 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 07:29:50 INFO - PROCESS | 31611 | |6;imaging-darkroom;146;146;146;146;147;146;146;147;147;146 07:29:50 INFO - PROCESS | 31611 | |7;imaging-desaturate;95;95;95;95;96;95;95;96;95;95 07:29:50 INFO - PROCESS | 31611 | |8;json-parse-financial;65;66;68;66;67;65;65;66;75;74 07:29:50 INFO - PROCESS | 31611 | |9;json-stringify-tinderbox;64;65;65;66;66;66;65;65;65;65 07:29:50 INFO - PROCESS | 31611 | |10;stanford-crypto-aes;82;80;80;90;82;83;81;89;81;81 07:29:50 INFO - PROCESS | 31611 | |11;stanford-crypto-ccm;128;121;121;123;116;124;116;118;119;117 07:29:50 INFO - PROCESS | 31611 | |12;stanford-crypto-pbkdf2;159;137;138;134;145;132;156;144;144;143 07:29:50 INFO - PROCESS | 31611 | |13;stanford-crypto-sha256-iterative;70;72;69;69;69;68;69;70;66;67 07:29:50 INFO - PROCESS | 31611 | __end_tp_report 07:29:50 INFO - PROCESS | 31611 | __start_cc_report 07:29:50 INFO - PROCESS | 31611 | _x_x_mozilla_cycle_collect,1083 07:29:50 INFO - PROCESS | 31611 | __end_cc_report 07:29:50 INFO - PROCESS | 31611 | __startTimestamp1467037790981__endTimestamp 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | ------- Summary: start ------- 07:29:50 INFO - PROCESS | 31611 | Number of tests: 14 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | [#0] ai-astar Cycles:10 Average:115.30 Median:114.00 stddev:4.16 (3.7%) stddev-sans-first:4.39 07:29:50 INFO - PROCESS | 31611 | Values: 114.0 113.0 114.0 114.0 115.0 114.0 114.0 115.0 113.0 127.0 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:157.50 stddev:17.44 (11.1%) stddev-sans-first:18.34 07:29:50 INFO - PROCESS | 31611 | Values: 158.0 132.0 156.0 177.0 133.0 157.0 160.0 134.0 175.0 133.0 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 07:29:50 INFO - PROCESS | 31611 | Values: 163.0 162.0 163.0 162.0 162.0 162.0 161.0 162.0 161.0 162.0 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.50 stddev:35.36 (46.8%) stddev-sans-first:36.84 07:29:50 INFO - PROCESS | 31611 | Values: 73.0 76.0 74.0 156.0 77.0 74.0 76.0 77.0 162.0 75.0 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:94.00 stddev:20.22 (21.5%) stddev-sans-first:20.84 07:29:50 INFO - PROCESS | 31611 | Values: 94.0 94.0 134.0 94.0 95.0 94.0 136.0 98.0 96.0 140.0 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:29:50 INFO - PROCESS | 31611 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:29:50 INFO - PROCESS | 31611 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:29:50 INFO - PROCESS | 31611 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:66.50 stddev:3.71 (5.6%) stddev-sans-first:3.81 07:29:50 INFO - PROCESS | 31611 | Values: 65.0 66.0 68.0 66.0 67.0 65.0 65.0 66.0 75.0 74.0 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 07:29:50 INFO - PROCESS | 31611 | Values: 64.0 65.0 65.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 07:29:50 INFO - PROCESS | 31611 | 07:29:50 INFO - PROCESS | 31611 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:3.60 (4.4%) stddev-sans-first:3.81 07:29:50 INFO - PROCESS | 31611 | Values: 82.0 80.0 80.0 90.0 82.0 83.0 81.0 89.0 81.0 81.0 07:29:51 INFO - PROCESS | 31611 | 07:29:51 INFO - PROCESS | 31611 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:121.00 stddev:3.89 (3.2%) stddev-sans-first:2.96 07:29:51 INFO - PROCESS | 31611 | Values: 128.0 121.0 121.0 123.0 116.0 124.0 116.0 118.0 119.0 117.0 07:29:51 INFO - PROCESS | 31611 | 07:29:51 INFO - PROCESS | 31611 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:144.00 stddev:8.78 (6.1%) stddev-sans-first:7.21 07:29:51 INFO - PROCESS | 31611 | Values: 159.0 137.0 138.0 134.0 145.0 132.0 156.0 144.0 144.0 143.0 07:29:51 INFO - PROCESS | 31611 | 07:29:51 INFO - PROCESS | 31611 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.72 07:29:51 INFO - PROCESS | 31611 | Values: 70.0 72.0 69.0 69.0 69.0 68.0 69.0 70.0 66.0 67.0 07:29:51 INFO - PROCESS | 31611 | -------- Summary: end -------- 07:29:51 INFO - PROCESS | 31611 | 07:29:51 INFO - TEST-INFO | 31611: exit 0 07:29:51 INFO - TEST-OK | kraken | took 60443ms 07:29:51 INFO - SUITE-END | took 1174s 07:29:52 INFO - Completed test suite (00:19:34) 07:29:52 INFO - javascript benchmark 07:29:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2781.7635500982415, 2836.900708475203, 2841.630588023557, 2869.0245316592354, 2881.4237152569476, 4624.815007399704, 4683.765811709418, 4691.483936766957, 4708.0, 4708.811647534095, 4671.22924717422, 4686.859394218179, 4701.717896926187, 4704.482506924235, 4725.480197178316, 4167.062410957541, 4233.1956928183545, 4306.074194048279, 4319.071399649075, 4349.26062569364, 4224.345226489883, 4229.851955181569, 4243.957560424403, 4247.341662042389, 4319.265724826787, 4259.16946195492, 4315.697901146921, 4331.956680433187, 4333.891652708676, 4353.869383918472, 4273.572642735733, 4290.05618763873, 4315.633171180453, 4319.654427645781, 4341.2836881914445, 4111.773852438115, 4223.535411104776, 4272.060146767737, 4324.070324880166, 4324.805383757738, 4556.8860778480475, 4577.5880170784785, 4594.19601569724, 4616.6537509686905, 4618.284165954283, 4956.975215123901, 4980.526849949285, 4981.825636102755, 4982.651214414992, 5012.423571289312, 4767.880802979918, 4939.234418665113, 4993.425756038066, 5003.524665156804, 5024.497550244982, 4602.424696912853, 4606.861794146181, 4620.422447194101, 4625.629949604024, 4648.163330600524, 4906.165951788204, 5037.143685573388, 5042.949570504321, 5043.193089105725, 5072.746362681851, 4743.762811859393, 4794.664373493822, 4799.160146974265, 4819.49395313494, 4822.95177048225, 4826.6621336506105, 4867.488913664014, 4873.902521949542, 4889.804407823718, 4914.410270767531, 4692.483826779052, 4788.281757736368, 4796.856094317176, 4800.207965685692, 4837.105135549935, 4870.780814863339, 4908.288298196741, 4932.038252540792, 4942.678725882806, 4950.43070046942, 4183.518895327015, 4186.790660466964, 4192.329227323614, 4212.957870421318, 4212.978935105366, 3669.8165091745304, 3710.6289371062676, 3725.1432170600374, 3726.1616136369644, 3755.7934313613014, 4326.610605045561, 4333.653307735437, 4346.500152482442, 4361.672874534359, 4363.803628836647, 4894.706317620954, 4924.43369012561, 4933.50664933511, 4990.600751939909, 5017.0216807722145, 4210.2842516772225, 4322.589354011364, 4334.848280310174, 4374.256376416017, 4410.117976404667, 4501.0, 4501.459824821042, 4511.8195272189405, 4516.480604730498, 4555.3850230218495, 4795.6163506919365, 4834.830780922721, 4840.346553215341, 4841.225403935354, 4863.440704319049, 4820.301056346881, 4948.925766113583, 4972.353594032753, 5012.699238045729, 5037.244413338029, 4705.058988202305, 4737.8341758038305, 4747.667663263676, 4754.191787396082, 4775.904481910412, 4853.514648535118, 4865.464798872051, 4865.6107511398295, 4865.805367785249, 4888.9755551222015, 4792.9281060784815, 4926.729029903389, 4996.825111121093, 5005.149124648746, 5026.070177017264, 4720.984988227548, 4732.337472753886, 4754.286856971482, 4755.239161734106, 4784.114938736345, 4587.151376995266, 4734.337192792943, 4735.621150308036, 4741.312509686008, 4765.285207218945, 4576.336431217522, 4671.579557839811, 4697.0, 4745.525447455227, 4784.545468180518, 4832.420109586872, 4851.078295123915, 4855.0, 4855.344528488608, 4875.902481950412, 4524.524924882971, 4715.0805592909055, 4719.716816990855, 4720.055988802184, 4723.031778485333], "unit": "score", "name": "dojo.html", "value": 4560.374702935581}, {"lowerIsBetter": false, "replicates": [510.84674597620705, 534.2467121358883, 566.8299510146954, 567.6650776042136, 585.1369230385183, 28264.293392665193, 35366.46950295744, 36024.45963310552, 36141.277174456496, 36156.0, 38591.80704096483, 39121.413178802344, 39139.0, 39185.60814391855, 39264.41103383445, 7970.322522585573, 8161.75514734556, 8166.510009399455, 8170.264676179143, 8170.714025009126, 8005.599720013976, 8123.553204573746, 8142.837143257131, 8144.4298899077085, 8349.624266907973, 8317.126701696325, 8397.286230670401, 8412.03261624915, 8437.70468033619, 8440.240378365947, 8305.584720763967, 8391.370647201484, 8399.37004724648, 8400.705975290897, 8401.327893768514, 8190.140035296267, 8325.500469971821, 8326.875096873551, 8327.541985190812, 8329.08380078191, 39297.80351098226, 39729.40405893914, 39816.40275395871, 39820.402693959615, 39846.60153398487, 2716.7283271672673, 2757.765589924859, 2801.831890086601, 2835.773138148943, 2933.3839893622367, 30449.695503045128, 31070.53394199089, 31076.844615776776, 31179.50563954878, 31265.374692506022, 3057.8623961921767, 3090.3355778507503, 3091.4435401627698, 3159.794613350125, 3198.616166060064, 231918.0, 232019.0, 232475.0, 232826.0, 233046.0, 40520.594794052275, 55741.72129139328, 56469.0, 56498.43501565014, 56500.71749641225, 43136.352954705704, 43382.78308608437, 43419.782901085295, 43435.34846977235, 43485.56514434879, 12623.810642840364, 12784.744305113845, 12788.232706037668, 12789.040821938206, 12806.103572750004, 9985.650502232387, 10105.696829095139, 10110.0, 10112.241581881388, 10116.645917392856, 14489.130652160904, 14541.41834326615, 14541.709165816836, 14544.0, 14644.487442939446, 5598.188262701886, 5629.24005259293, 5645.633033852787, 5736.741846616912, 5738.368779434259, 951.8810148731409, 1005.7686732051523, 1009.7526106104051, 1027.4811220333684, 1029.464678367245, 27429.45141097167, 27824.721752782618, 28597.57103643447, 28610.427791444054, 28804.42391152207, 949.4493193947494, 993.9155171810332, 1018.6231094495084, 1047.1831971062584, 1048.816457120001, 13301.0, 13854.93072534651, 13991.58025259244, 14065.367058482392, 14283.714325713427, 354373.0, 360885.0, 362338.0, 363267.0, 363632.0, 50613.493865060875, 50635.0, 51181.7440912793, 51430.22854657183, 51442.74278628583, 1121.3832392184265, 1177.7526719388852, 1257.6792917805901, 1294.326949986002, 1329.8271224740722, 25384.873075634503, 27719.30701732473, 27810.0, 27920.0, 27953.860230698716, 41230.79384603058, 41577.37633935433, 41781.58218417777, 41886.37170442385, 41920.3711944315, 217236.0, 218771.0, 219001.0, 219201.0, 219268.0, 25823.741762582886, 30234.54648180323, 30889.845550773, 31068.22329441782, 31135.688643114187, 36184.27631447409, 39330.41004384994, 39335.213295734495, 39761.60238397695, 39786.403203951384, 32728.83635581902, 32869.67130328666, 32943.50584741183, 33041.33917321688, 33182.0, 32907.17732056622, 32929.176770580925, 33010.66989330172, 33068.66931330656, 34109.82945085259, 33467.33065338631, 33864.322713546084, 33959.32081358408, 34127.4880876792, 34362.0, 29987.70012299849, 30196.396072077994, 30334.69665303319, 30592.388152237276, 30656.0, 23504.41238968971, 23874.761252387252, 24157.63763543513, 24278.757212428358, 24399.0], "unit": "score", "name": "ext.html", "value": 16790.182802582214}, {"lowerIsBetter": false, "replicates": [350.43929712460067, 354.67901549098076, 355.4064711931075, 355.46679980029955, 355.95728512578495, 16482.587935301624, 16867.072311022905, 16883.83116168838, 17237.482875513724, 17251.568710782205, 13835.515756948509, 14127.92936035321, 14268.357923893424, 14280.71438571228, 14288.857111428882, 4886.63350248731, 4941.135301322272, 5125.513076257749, 5129.9227162295965, 5139.8458046258675, 3492.912677183065, 4955.45489996102, 5164.896702065976, 5170.974145129269, 5185.55922746567, 5175.456577059411, 5199.220116982445, 5200.401953775307, 5210.895782084356, 5222.738863056851, 5013.172826483626, 5168.276441298202, 5232.764525596357, 5250.081235783741, 5255.553277971377, 5018.397792264952, 5020.046191223692, 5027.698338099689, 5032.798688052473, 5110.718910459923, 11850.525978960832, 12027.699307517294, 12100.81848772269, 12122.151449398458, 12167.878321216764, 1774.21047633803, 1906.266087556287, 1969.980300196994, 1995.6152397884534, 2416.2509622017233, 8540.658373665108, 9273.907260927439, 10041.347312424741, 11007.67907851055, 12290.938545307306, 1646.7529870519397, 1762.8237176282398, 1767.45435817821, 1783.8929664220188, 1794.6231291428685, 56506.0, 56985.0, 57023.714881425745, 57564.424355756324, 58634.0, 9330.766730831783, 9435.622575097057, 9601.087896649948, 9645.08371704687, 9712.562934667956, 12906.870931290567, 12964.870351296555, 12983.545575904798, 12983.805242921364, 13007.219566826021, 6636.601803891782, 6744.22441419243, 6778.084958530634, 6850.794476165624, 6862.073620061327, 6275.843103922439, 6303.6532990685955, 6365.204349456318, 6383.585066970632, 6411.839704007344, 4152.501699796044, 4168.937465938014, 4234.915301693949, 4237.364395340662, 4263.786810659454, 1544.7065057639013, 1571.834957329464, 1608.3807734022253, 1694.0, 1756.7628370170119, 837.656560810065, 878.7759121423996, 960.9135177834029, 977.5698692575244, 977.5747549815853, 15068.924655376872, 15195.544133676007, 15573.610659733371, 15633.765493517607, 15739.606509837346, 900.4102312985005, 911.289194428347, 932.2495391210141, 949.520492151459, 982.2142286171035, 8939.061398553058, 9158.40470369424, 9297.256219502424, 9381.859272110923, 9426.387284826602, 407594.0, 414621.0, 418146.0, 425764.0, 436206.0, 68564.31435685679, 70555.2944470559, 70760.2923970764, 71550.28449715437, 72828.63585682143, 943.1605870775015, 951.2342564235719, 966.3184662561448, 968.7287559483356, 972.4700038479045, 14468.493602723855, 14559.563213103624, 14620.0, 14711.779323310373, 14853.0, 30651.386972260876, 31284.37431251408, 32392.0, 32550.83724581362, 32937.17657058497, 45868.54131458776, 46477.767611161726, 46611.0, 46798.0, 46817.06365872595, 7395.519291246052, 7410.96294518524, 7418.0, 7652.158262591, 7661.961690191513, 9998.750031249278, 11574.942125289657, 11664.183507154417, 11676.532938682698, 11881.881181188077, 9539.902911165027, 9692.612295508101, 9748.512574371394, 10142.746431339276, 10145.34055286404, 9693.27300452483, 9858.211343092678, 10085.899141008496, 10169.338992965433, 10281.074703276741, 9956.701298961043, 10122.696319110439, 10207.591696332063, 10243.590256389662, 10507.159427245955, 7377.3360397564475, 7478.588677622783, 7486.5508069516, 7487.438442116972, 7557.5465472071855, 8638.697645582375, 9956.452395118338, 10066.8489972649, 10100.848487272844, 10401.427921464392], "unit": "score", "name": "jquery.html", "value": 7790.840327427409}, {"lowerIsBetter": false, "replicates": [1288.7164823738774, 1443.1918125849525, 1459.7737350710643, 1632.4368093007915, 1842.530154810523, 7413.295736904992, 7590.3548198403205, 7597.31624153826, 7600.429967752413, 7608.505447145932, 7486.213947535499, 7629.618519074052, 7636.083669959598, 7642.04474440695, 7644.273793989576, 2159.427751645815, 2181.4655409424713, 2184.9344519664437, 2185.5519618478174, 2185.67214917762, 2206.3160420269687, 2231.7991380775725, 2286.748457669655, 2289.69089172962, 2293.8508996915148, 2193.056985496244, 2209.635410157322, 2213.4134454369605, 2214.3910424633273, 2239.2386588559884, 2166.729158855143, 2176.5320456101936, 2189.3322536626324, 2192.0683709423593, 2193.56128774245, 2242.0471299697565, 2245.786650268222, 2257.920972765962, 2258.446680563256, 2264.060414927803, 7740.845183096363, 7776.961115194445, 7784.494007889469, 7784.844303113962, 7804.687812487494, 4240.872773816791, 4368.017196130877, 4368.847090351823, 4388.407564978719, 4392.450943632046, 2702.6891907430504, 2872.0, 2887.5524293734507, 2904.0852131578695, 2911.898083567065, 844.2317491083085, 870.5342641686731, 878.83302172587, 884.9955750221208, 889.3996552327153, 10653.201009924287, 10729.0, 10737.302075365076, 10756.139508839275, 10759.139268858473, 4062.898427539276, 4172.624463798273, 4193.5387107418155, 4196.097838964637, 4260.382244574519, 9157.862632060524, 9195.494247816434, 9197.448153110834, 9208.033156518602, 9236.8614470783, 4433.889152771142, 4438.423005009328, 4441.933370999438, 4442.511323754385, 4451.554844515523, 3319.054069590155, 3783.375743002374, 3931.292367373843, 3991.102002049574, 4028.576999415019, 3509.754317197772, 3562.287542491512, 3588.3361578108133, 3606.6753992140307, 3615.475756015363, 1158.9942050289694, 1166.311875993168, 1175.2126075529416, 1178.622840690988, 1180.4392913366255, 1218.2020776391478, 1224.1064023263068, 1232.353014667289, 1233.2600439736086, 1254.0406588959454, 7241.710331586783, 7268.309510596485, 7297.781066568012, 7411.295926886937, 7449.44129190302, 451.7334772484184, 460.4198709625829, 464.9418822647169, 465.862570541691, 466.0422831082159, 5380.78476860929, 5386.811461598825, 5387.111126664135, 5393.487618676298, 5415.647982881179, 9039.09609039104, 9271.304652151115, 9546.474943878153, 9557.378770379903, 9588.424694518351, 9292.303077269233, 9295.814083718424, 9299.0, 9318.580663870142, 9336.206422454032, 6770.492213084039, 6978.162620485574, 6978.197507286625, 6995.510314277952, 7113.110861142357, 7094.077769889881, 7094.858102837811, 7096.680649370894, 7117.181524124792, 7165.3551180394015, 8108.2297181767635, 8299.751007469786, 8317.168283171635, 8322.250997410261, 8358.414910956175, 8316.83366332682, 8504.0, 8512.829743405222, 8639.04970453237, 8651.567421629019, 6186.443220110032, 6292.811215663354, 6365.0, 6373.840653983688, 6403.519736019724, 6992.755253566101, 7001.474889383215, 7038.859222815618, 7047.08387909589, 7065.258147894603, 6286.622802631674, 6468.773592924225, 6520.641364724986, 6533.575317604341, 6599.175103112111, 6079.726412311545, 6175.59858609189, 6214.8135555933395, 6260.780872669435, 6357.96821015892, 6757.662116894234, 6776.220734615582, 6804.353586409283, 6815.89776153368, 6823.351781580742, 6053.848653783691, 6071.392860713893, 6083.178770865877, 6095.847603809941, 6130.785422510191, 6120.7551697931585, 6145.938540614537, 6172.629642221481, 6174.598651087665, 6194.752209911553], "unit": "score", "name": "mootools.html", "value": 4235.227110086914}, {"lowerIsBetter": false, "replicates": [326.5232760170152, 332.2607198982264, 332.7354752971389, 335.7247057412922, 339.8810416354275, 5391.595630327722, 5432.782688692452, 5439.809606663767, 5447.591430642703, 5448.673079615226, 5327.041132596131, 5329.680219186852, 5330.813421530247, 5332.57339412847, 5395.136778115502, 4048.109415928491, 4132.566080561543, 4199.9580004200025, 4278.229918614656, 4304.935425968613, 4272.252355837732, 4280.443542339492, 4282.03654177809, 4296.48442186938, 4302.849400270991, 4249.213895429355, 4261.2329780639475, 4262.211490874182, 4262.531121576624, 4271.295236286009, 4021.9597804022023, 4116.300228961084, 4178.435911152016, 4196.181744559812, 4219.7046206765535, 3770.076331298822, 3772.7170462215445, 3777.1690228149764, 3780.9054773630605, 3782.8865134046023, 5240.449752775941, 5251.711155886424, 5260.763265653055, 5262.315898933152, 5267.552258058031, 4894.339264199323, 4896.46138924718, 4902.8774280643265, 4908.190148625473, 4918.188498897677, 5696.943030569682, 5710.943475457054, 5713.171590119451, 5718.228039214736, 5724.39893811148, 3865.903352416184, 4129.793510324472, 4137.668986481074, 4138.875833724993, 4143.067809742814, 5850.122481627747, 5951.047832346804, 5986.610870293461, 5993.430624090748, 6014.699265036731, 4114.177164567039, 4119.855805046809, 4119.876403707894, 4127.153933443637, 4129.97935010323, 4188.183304255702, 4188.790560471964, 4193.748375097504, 4196.139791342767, 4196.91606167881, 4793.688410253322, 4798.0, 4807.567318941312, 4810.807567697323, 4812.614990800797, 5717.342505611825, 5728.627639203439, 5730.255066841284, 5733.254676891977, 5733.73517460609, 1423.6227399739078, 1461.3277892169508, 1469.7648376259747, 1481.029925398844, 1484.6511069898565, 928.8838895138108, 941.4868896451451, 970.6505657963128, 987.9654212102541, 989.0455710239653, 5047.343845300161, 5110.4634013428795, 5136.871578210575, 5148.897022059537, 5158.071547121554, 6019.307779605401, 6030.638161710223, 6060.787872424444, 6097.512199024068, 6099.420555047263, 5180.585553155738, 5184.222366645034, 5185.688858668492, 5185.818496352609, 5189.948100519022, 3187.123541026236, 3225.3710526447117, 3227.386796508656, 3231.4829627259523, 3232.321212545392, 5613.0, 5759.337676167294, 5764.106563482667, 5766.4233576642, 5767.250257466502, 6135.785247516315, 6137.171481849893, 6144.539159563051, 6146.846328841725, 6155.630662160284, 5719.456651618089, 5736.541076713853, 5744.856378590569, 5751.1085781703905, 5759.193712880284, 5984.9401505986125, 5986.491148252273, 5996.790112346047, 5999.4900433463645, 6003.6998150093195, 5849.473547380756, 5852.795152169653, 5858.355580886185, 5865.090910908816, 5868.911966320423, 5577.609567330248, 5708.80019199326, 5734.799282025109, 5741.569382296261, 5757.222774925332, 4133.772642504691, 4156.9792151040265, 4158.147579746205, 4164.000639846355, 4165.833366665421, 5972.044472884318, 5976.043832986701, 5977.462028417463, 6018.578699490994, 6065.696715164136, 5725.370209277059, 5773.595848290579, 5774.105013722879, 5775.566832487664, 5779.450952159538, 5744.425557444222, 5757.280339957505, 5760.251167348218, 5764.221830052889, 5777.711114444345, 5493.587980901529, 5648.943510564842, 5655.547556195576, 5661.320641523043, 5671.546276297969, 5791.420857914175, 5809.302883653989, 5810.82567522975, 5817.94182058174, 5822.7670893163795, 5623.803166889139, 5625.212470254086, 5628.774849005994, 5636.5208957237455, 5639.154126881001], "unit": "score", "name": "prototype.html", "value": 4340.85163502036}, {"lowerIsBetter": false, "replicates": [644.9226092868855, 656.7176114270864, 662.6752891083368, 666.7499687617144, 687.1925487552126, 11295.887041129587, 11406.372649504274, 11422.14333924957, 11506.42467876606, 11534.192606517547, 10825.621103261368, 10895.83656245157, 10965.232433729621, 10978.560857565688, 10986.890131098686, 683.6171743823475, 830.0495932157676, 837.1126605797858, 852.2031900173358, 862.3015357560396, 852.2968550945495, 859.8667206582959, 861.2808305065247, 862.1550880137469, 862.7972426479772, 905.0903841639143, 905.8369493491169, 905.868649045888, 905.9229965452945, 906.1618003346911, 724.9492535522515, 870.8911386076741, 887.6626881784945, 888.3337496877342, 900.5002223765807, 659.6932426421689, 661.5369241530948, 662.2384258103172, 662.529603981174, 662.9270780214221, 10133.189344852393, 10192.74518137045, 10212.080912717816, 10247.897521024768, 10302.278840481169, 11281.32312061279, 11619.453248811427, 12429.192102513307, 12645.92509636682, 12665.493380264777, 8307.08622051574, 8358.113795868801, 8523.659053637846, 8542.103079176659, 8577.957110214471, 3289.1283809790425, 3323.252268239651, 3336.1492819331156, 3372.426687463137, 3393.389189945809, 40042.199156017006, 40331.59668403308, 40602.390964135564, 41549.0, 41591.999999999694, 9793.118619324296, 9850.950745246228, 9890.901090988998, 9920.057594528509, 9930.304878658424, 16965.575860603338, 17113.828861711474, 17128.91435542839, 17181.656366872594, 17565.912170439322, 6366.204224471941, 6460.257070436866, 6479.254885688206, 6486.740530378826, 6504.772332968323, 3584.713222942158, 3588.1926566522325, 3605.603383627799, 3629.292288003814, 3703.9074023149637, 2692.9730702693114, 2707.039001154601, 2707.160780158118, 2710.9728902711113, 2731.440054788803, 507.6142131979722, 514.1952843799442, 518.0002594991702, 520.5731300333765, 525.7450136683706, 434.6978849699492, 436.8427366148184, 510.6859281541825, 540.5513423858188, 549.8240563019796, 6961.895571566431, 7202.855942881218, 7251.311125443074, 7303.817404564928, 7360.668769905367, 435.4904761429072, 460.4612603254201, 485.9708417494962, 494.7377889718455, 509.7909856958629, 3300.290437555937, 3314.834258287076, 3317.93364132716, 3398.932021359559, 3473.4789781532468, 47834.521654783704, 50814.49185508172, 50819.74590127026, 50902.23646645303, 50917.0, 45803.3129503051, 46194.76902615465, 46665.0, 46831.76584117058, 46996.7650161747, 41025.0, 41093.58906410898, 41213.79393103015, 41296.587034129276, 41398.37902431466, 6665.300143484864, 6716.059751634677, 6756.729730810713, 6775.390214880685, 6857.5199736018, 32080.35839283248, 32541.511877322333, 32696.0, 32760.344793104483, 33169.336613267114, 39647.40528892011, 40924.18151636891, 41386.58613413948, 41458.58541414547, 41527.58472415358, 7875.133735288999, 8127.268545830903, 8391.244787969112, 8432.578371081545, 8476.321894248322, 8783.91216087831, 8923.776905577413, 9039.728808135766, 9062.04848490899, 9152.95423522878, 8200.138985406445, 8310.044344900172, 8545.786355340917, 8553.401261911606, 8566.700165494178, 8584.141585841366, 8633.568321584022, 8695.391322607356, 8797.868031979653, 8804.86792698123, 8431.747047588582, 8462.11147829469, 8619.6983105591, 8651.567421629019, 8652.697155599524, 7094.11323584552, 7356.4114870809135, 7416.96291518539, 7443.888341674771, 7454.850902982019, 7153.319582698138, 7169.318914703304, 7331.120265568166, 7344.853102938018, 7431.962840185764], "unit": "score", "name": "yui.html", "value": 5437.474912375848}], "name": "dromaeo_css", "value": 6250.603196799263}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 113.0, 127.0], "unit": "score", "name": "ai-astar", "value": 115.3}, {"lowerIsBetter": true, "replicates": [158.0, 132.0, 156.0, 177.0, 133.0, 157.0, 160.0, 134.0, 175.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 74.0, 156.0, 77.0, 74.0, 76.0, 77.0, 162.0, 75.0], "unit": "score", "name": "audio-fft", "value": 92.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 134.0, 94.0, 95.0, 94.0, 136.0, 98.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 68.0, 66.0, 67.0, 65.0, 65.0, 66.0, 75.0, 74.0], "unit": "score", "name": "json-parse-financial", "value": 67.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 80.0, 90.0, 82.0, 83.0, 81.0, 89.0, 81.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [128.0, 121.0, 121.0, 123.0, 116.0, 124.0, 116.0, 118.0, 119.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.3}, {"lowerIsBetter": true, "replicates": [159.0, 137.0, 138.0, 134.0, 145.0, 132.0, 156.0, 144.0, 144.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 69.0, 69.0, 69.0, 68.0, 69.0, 70.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1534.9000000000003}]} 07:29:52 INFO - Return code: 0 07:29:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:29:52 INFO - # TBPL SUCCESS # 07:29:52 INFO - Running post-action listener: _resource_record_post_action 07:29:52 INFO - Running post-run listener: _resource_record_post_run 07:29:53 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 488259584; Read time: 24; Write time: 407652 07:29:53 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237686784; Read time: 0; Write time: 241164 07:29:53 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 249974784; Read time: 24; Write time: 166488 07:29:53 INFO - Running post-run listener: _upload_blobber_files 07:29:53 INFO - Blob upload gear active. 07:29:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:29:53 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 07:29:53 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:29:53 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:29:53 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:29:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:29:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:54 INFO - (blobuploader) - INFO - Done attempting. 07:29:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:55 INFO - (blobuploader) - INFO - Done attempting. 07:29:55 INFO - (blobuploader) - INFO - Iteration through files over. 07:29:55 INFO - Return code: 0 07:29:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:29:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:29:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/8861d70f4e4d0c6468d89f89bec6d3519ccb2eeb939c4c680f0708e324d1d0f11c5a367188ccd963826595f1e30287a6e2ad81b7a1947b93336c0d88c540acea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/62956ae127ea1782dca7b2ac0402855cc505d9f08bdd52f275cad0160d202083937ea24684c2ff9cb6561ccafc00dda04246d2ded5f1015a719224ef0a8a4c90"} 07:29:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:29:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:29:55 INFO - Contents: 07:29:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/8861d70f4e4d0c6468d89f89bec6d3519ccb2eeb939c4c680f0708e324d1d0f11c5a367188ccd963826595f1e30287a6e2ad81b7a1947b93336c0d88c540acea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/62956ae127ea1782dca7b2ac0402855cc505d9f08bdd52f275cad0160d202083937ea24684c2ff9cb6561ccafc00dda04246d2ded5f1015a719224ef0a8a4c90"} 07:29:55 INFO - Running post-run listener: copy_logs_to_upload_dir 07:29:55 INFO - Copying logs to upload dir... 07:29:55 INFO - mkdir: /builds/slave/test/build/upload/logs 07:29:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.225504 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-27 07:29:51.977368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 07:29:51.980452) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/8861d70f4e4d0c6468d89f89bec6d3519ccb2eeb939c4c680f0708e324d1d0f11c5a367188ccd963826595f1e30287a6e2ad81b7a1947b93336c0d88c540acea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/62956ae127ea1782dca7b2ac0402855cc505d9f08bdd52f275cad0160d202083937ea24684c2ff9cb6561ccafc00dda04246d2ded5f1015a719224ef0a8a4c90"} build_url:https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/E6NmOASEQFO2p6OvG_0Orw/artifacts/public/build/firefox-47.0.1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/8861d70f4e4d0c6468d89f89bec6d3519ccb2eeb939c4c680f0708e324d1d0f11c5a367188ccd963826595f1e30287a6e2ad81b7a1947b93336c0d88c540acea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/62956ae127ea1782dca7b2ac0402855cc505d9f08bdd52f275cad0160d202083937ea24684c2ff9cb6561ccafc00dda04246d2ded5f1015a719224ef0a8a4c90"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 07:29:52.005466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:29:52.005750) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467036174.982541-601695572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:29:52.087685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 07:29:52.088015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 07:29:52.088308) ========= ========= Total master_lag: 0.17 =========