builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1466673800.37 results: success (0) buildid: 20160622233407 builduid: 7adcbaeb1ce34cd6a5336eff7b5c26c8 revision: fd26cef5ff88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:20.368340) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:20.368815) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:20.369107) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:20.385498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:20.385887) ========= 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=cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 02:23:22-- 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% 94.5M=0s 2016-06-23 02:23:22 (94.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104326 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:20.503927) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:20.504264) ========= 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=cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015774 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:20.554096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:20.554456) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fd26cef5ff88 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fd26cef5ff88 --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=cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 02:23:22,527 Setting DEBUG logging. 2016-06-23 02:23:22,527 attempt 1/10 2016-06-23 02:23:22,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fd26cef5ff88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 02:23:22,837 unpacking tar archive at: mozilla-inbound-fd26cef5ff88/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681827 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:21.249700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:21.250020) ========= script_repo_revision: fd26cef5ff88 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:21.250454) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:21.250728) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 02:23:21.260151) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-23 02:23:21.260567) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:23:23 INFO - MultiFileLogger online at 20160623 02:23:23 in /builds/slave/test 02:23:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 02:23:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:23:23 INFO - {'append_to_log': False, 02:23:23 INFO - 'base_work_dir': '/builds/slave/test', 02:23:23 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:23:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:23:23 INFO - 'branch': 'Mozilla-Inbound', 02:23:23 INFO - 'buildbot_json_path': 'buildprops.json', 02:23:23 INFO - 'config_files': ('talos/linux_config.py',), 02:23:23 INFO - 'default_actions': ('clobber', 02:23:23 INFO - 'read-buildbot-config', 02:23:23 INFO - 'download-and-extract', 02:23:23 INFO - 'populate-webroot', 02:23:23 INFO - 'create-virtualenv', 02:23:23 INFO - 'install', 02:23:23 INFO - 'run-tests'), 02:23:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:23:23 INFO - 'download_minidump_stackwalk': True, 02:23:23 INFO - 'download_symbols': 'ondemand', 02:23:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:23:23 INFO - 'tooltool.py': '/tools/tooltool.py', 02:23:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:23:23 INFO - '/tools/misc-python/virtualenv.py')}, 02:23:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:23:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:23:23 INFO - 'installer_path': 'installer.exe', 02:23:23 INFO - 'log_level': 'info', 02:23:23 INFO - 'log_name': 'talos', 02:23:23 INFO - 'log_to_console': True, 02:23:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:23:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:23:23 INFO - 'opt_config_files': (), 02:23:23 INFO - 'pip_index': False, 02:23:23 INFO - 'sps_profile': False, 02:23:23 INFO - 'sps_profile_interval': 0, 02:23:23 INFO - 'suite': 'dromaeojs', 02:23:23 INFO - 'system_bits': '32', 02:23:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:23:23 INFO - 'title': 'talos-linux64-ix-054', 02:23:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:23:23 INFO - 'use_talos_json': True, 02:23:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:23:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:23:23 INFO - 'work_dir': 'build'} 02:23:23 INFO - ##### 02:23:23 INFO - ##### Running clobber step. 02:23:23 INFO - ##### 02:23:23 INFO - Running pre-action listener: _resource_record_pre_action 02:23:23 INFO - Running main action method: clobber 02:23:23 INFO - rmtree: /builds/slave/test/build 02:23:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:23:23 INFO - Running post-action listener: _resource_record_post_action 02:23:23 INFO - ##### 02:23:23 INFO - ##### Finished clobber step (success) 02:23:23 INFO - ##### 02:23:23 INFO - ##### 02:23:23 INFO - ##### Running read-buildbot-config step. 02:23:23 INFO - ##### 02:23:23 INFO - Running pre-action listener: _resource_record_pre_action 02:23:23 INFO - Running main action method: read_buildbot_config 02:23:23 INFO - Using buildbot properties: 02:23:23 INFO - { 02:23:23 INFO - "project": "", 02:23:23 INFO - "product": "firefox", 02:23:23 INFO - "script_repo_revision": "production", 02:23:23 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 02:23:23 INFO - "repository": "", 02:23:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 02:23:23 INFO - "buildid": "20160622233407", 02:23:23 INFO - "pgo_build": "True", 02:23:23 INFO - "basedir": "/builds/slave/test", 02:23:23 INFO - "buildnumber": 1217, 02:23:23 INFO - "slavename": "talos-linux64-ix-054", 02:23:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:23:23 INFO - "platform": "ubuntu64_hw", 02:23:23 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:23:23 INFO - "branch": "mozilla-inbound", 02:23:23 INFO - "repo_path": "integration/mozilla-inbound", 02:23:23 INFO - "revision": "fd26cef5ff88", 02:23:23 INFO - "stage_platform": "linux64-pgo", 02:23:23 INFO - "builduid": "7adcbaeb1ce34cd6a5336eff7b5c26c8", 02:23:23 INFO - "slavebuilddir": "test" 02:23:23 INFO - } 02:23:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:23:23 INFO - Running post-action listener: _resource_record_post_action 02:23:23 INFO - ##### 02:23:23 INFO - ##### Finished read-buildbot-config step (success) 02:23:23 INFO - ##### 02:23:23 INFO - ##### 02:23:23 INFO - ##### Running download-and-extract step. 02:23:23 INFO - ##### 02:23:23 INFO - Running pre-action listener: _resource_record_pre_action 02:23:23 INFO - Running main action method: download_and_extract 02:23:23 INFO - mkdir: /builds/slave/test/build/tests 02:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:23 INFO - https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:23:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:23:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:23:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:23:24 INFO - Downloaded 1361 bytes. 02:23:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:23:24 INFO - Using the following test package requirements: 02:23:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:23:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:23:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:23:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'jsshell-linux-x86_64.zip'], 02:23:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:23:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:23:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:23:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:23:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:23:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:23:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:23: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')]} 02:23:24 INFO - https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:23:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:23:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:23:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:23:27 INFO - Downloaded 24269771 bytes. 02:23:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:23:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:23:28 INFO - Return code: 0 02:23:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:23:28 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')]} 02:23:28 INFO - https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:23:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:23:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:23:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:23:36 INFO - Downloaded 24269771 bytes. 02:23:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:23:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:23:37 INFO - Return code: 0 02:23:37 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')]} 02:23:37 INFO - https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:23:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:23:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:23:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:23:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:23:42 INFO - Downloaded 14405384 bytes. 02:23:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:23:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:23:42 INFO - Return code: 0 02:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:42 INFO - https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:23:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:23:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:23:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:23:53 INFO - Downloaded 60163812 bytes. 02:23:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:23:53 INFO - mkdir: /builds/slave/test/properties 02:23:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:23:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:23:53 INFO - Contents: 02:23:53 INFO - build_url:https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:23:54 INFO - Running post-action listener: _resource_record_post_action 02:23:54 INFO - Running post-action listener: set_extra_try_arguments 02:23:54 INFO - ##### 02:23:54 INFO - ##### Finished download-and-extract step (success) 02:23:54 INFO - ##### 02:23:54 INFO - ##### 02:23:54 INFO - ##### Running populate-webroot step. 02:23:54 INFO - ##### 02:23:54 INFO - Running pre-action listener: _resource_record_pre_action 02:23:54 INFO - Running main action method: populate_webroot 02:23:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:23:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:23:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:23:54 INFO - '--tppagecycles', 02:23:54 INFO - '7'], 02:23:54 INFO - 'tests': ['tsvgm']}}, 02:23:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:23:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:23:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:23:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:23:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:23:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:23:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:54 INFO - 'talos_options': ['--disable-e10s'], 02:23:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:54 INFO - 'talos_options': ['--disable-e10s'], 02:23:54 INFO - 'tests': ['damp', 'tps']}, 02:23:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:54 INFO - 'tests': ['damp', 'tps']}, 02:23:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:23:54 INFO - 'tests': ['dromaeo_dom']}, 02:23:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:23:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:23:54 INFO - 'tests': ['basic_compositor_video']}, 02:23:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:23:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:23:54 INFO - 'tests': ['a11yr', 02:23:54 INFO - 'ts_paint', 02:23:54 INFO - 'tpaint', 02:23:54 INFO - 'sessionrestore', 02:23:54 INFO - 'sessionrestore_no_auto_restore', 02:23:54 INFO - 'tabpaint']}, 02:23:54 INFO - 'other-e10s': {'tests': ['a11yr', 02:23:54 INFO - 'ts_paint', 02:23:54 INFO - 'tpaint', 02:23:54 INFO - 'sessionrestore', 02:23:54 INFO - 'sessionrestore_no_auto_restore', 02:23:54 INFO - 'tabpaint']}, 02:23:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:23:54 INFO - 'ts_paint', 02:23:54 INFO - 'tpaint', 02:23:54 INFO - 'sessionrestore', 02:23:54 INFO - 'sessionrestore_no_auto_restore', 02:23:54 INFO - 'tabpaint']}, 02:23:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:23:54 INFO - 'ts_paint', 02:23:54 INFO - 'tpaint', 02:23:54 INFO - 'sessionrestore', 02:23:54 INFO - 'sessionrestore_no_auto_restore', 02:23:54 INFO - 'tabpaint']}, 02:23:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:23:54 INFO - 'tests': ['a11yr', 02:23:54 INFO - 'ts_paint', 02:23:54 INFO - 'tpaint', 02:23:54 INFO - 'sessionrestore', 02:23:54 INFO - 'sessionrestore_no_auto_restore', 02:23:54 INFO - 'tabpaint']}, 02:23:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:23:54 INFO - 'tests': ['a11yr', 02:23:54 INFO - 'ts_paint', 02:23:54 INFO - 'tpaint', 02:23:54 INFO - 'sessionrestore', 02:23:54 INFO - 'sessionrestore_no_auto_restore', 02:23:54 INFO - 'tabpaint']}, 02:23:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:23:54 INFO - 'tests': ['tsvgx', 02:23:54 INFO - 'tsvgr_opacity', 02:23:54 INFO - 'tart', 02:23:54 INFO - 'tscrollx', 02:23:54 INFO - 'cart']}, 02:23:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:23:54 INFO - 'tsvgr_opacity', 02:23:54 INFO - 'tart', 02:23:54 INFO - 'tscrollx', 02:23:54 INFO - 'cart']}, 02:23:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:54 INFO - 'talos_options': ['--disable-e10s'], 02:23:54 INFO - 'tests': ['tp5o']}, 02:23:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:54 INFO - 'tests': ['tp5o']}, 02:23:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:54 INFO - 'talos_options': ['--disable-e10s', 02:23:54 INFO - '--xperf_path', 02:23:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:54 INFO - 'tests': ['tp5n']}, 02:23:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:54 INFO - 'talos_options': ['--xperf_path', 02:23:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:54 INFO - 'tests': ['tp5n']}}, 02:23:54 INFO - 'talos.zip': {'path': '', 02:23:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:23:54 INFO - Running post-action listener: _resource_record_post_action 02:23:54 INFO - ##### 02:23:54 INFO - ##### Finished populate-webroot step (success) 02:23:54 INFO - ##### 02:23:54 INFO - ##### 02:23:54 INFO - ##### Running create-virtualenv step. 02:23:54 INFO - ##### 02:23:54 INFO - Running pre-action listener: _resource_record_pre_action 02:23:54 INFO - Running main action method: create_virtualenv 02:23:54 INFO - Creating virtualenv /builds/slave/test/build/venv 02:23:54 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 02:23:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:23:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:23:54 INFO - Using real prefix '/usr' 02:23:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:23:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:23:56 INFO - Installing pip.................done. 02:23:56 INFO - Return code: 0 02:23:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c72566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81c0>, '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 0x10f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', '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 02:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:23:56 INFO - Using env: {'DISPLAY': ':0', 02:23:56 INFO - 'HOME': '/home/cltbld', 02:23:56 INFO - 'LANG': 'en_US.UTF-8', 02:23:56 INFO - 'LANGUAGE': 'en_US:en', 02:23:56 INFO - 'LOGNAME': 'cltbld', 02:23:56 INFO - 'MAIL': '/var/mail/cltbld', 02:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:56 INFO - 'MOZ_NO_REMOTE': '1', 02:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:56 INFO - 'NO_EM_RESTART': '1', 02:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:56 INFO - 'PWD': '/builds/slave/test', 02:23:56 INFO - 'SHELL': '/bin/bash', 02:23:56 INFO - 'SHLVL': '1', 02:23:56 INFO - 'TERM': 'linux', 02:23:56 INFO - 'TMOUT': '86400', 02:23:56 INFO - 'USER': 'cltbld', 02:23:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', 02:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:56 INFO - '_': '/tools/buildbot/bin/python'} 02:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:57 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 02:23:57 INFO - Cleaning up... 02:23:57 INFO - Return code: 0 02:23:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:23: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')]} 02:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c72566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81c0>, '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 0x10f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', '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 02:23: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:23: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 psutil>=3.1.1 02:23:57 INFO - Using env: {'DISPLAY': ':0', 02:23:57 INFO - 'HOME': '/home/cltbld', 02:23:57 INFO - 'LANG': 'en_US.UTF-8', 02:23:57 INFO - 'LANGUAGE': 'en_US:en', 02:23:57 INFO - 'LOGNAME': 'cltbld', 02:23:57 INFO - 'MAIL': '/var/mail/cltbld', 02:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:57 INFO - 'MOZ_NO_REMOTE': '1', 02:23:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:57 INFO - 'NO_EM_RESTART': '1', 02:23:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:57 INFO - 'PWD': '/builds/slave/test', 02:23:57 INFO - 'SHELL': '/bin/bash', 02:23:57 INFO - 'SHLVL': '1', 02:23:57 INFO - 'TERM': 'linux', 02:23:57 INFO - 'TMOUT': '86400', 02:23:57 INFO - 'USER': 'cltbld', 02:23:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', 02:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:57 INFO - '_': '/tools/buildbot/bin/python'} 02:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:57 INFO - Downloading/unpacking psutil>=3.1.1 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:23:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:23:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:59 INFO - Installing collected packages: psutil 02:23:59 INFO - Running setup.py install for psutil 02:23:59 INFO - building 'psutil._psutil_linux' extension 02:23:59 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 02:23:59 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 02:23:59 INFO - building 'psutil._psutil_posix' extension 02:23:59 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 02:23:59 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 02:23:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:23:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:59 INFO - Successfully installed psutil 02:23:59 INFO - Cleaning up... 02:23:59 INFO - Return code: 0 02:23:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c72566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81c0>, '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 0x10f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', '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 02:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:23:59 INFO - Using env: {'DISPLAY': ':0', 02:23:59 INFO - 'HOME': '/home/cltbld', 02:23:59 INFO - 'LANG': 'en_US.UTF-8', 02:23:59 INFO - 'LANGUAGE': 'en_US:en', 02:23:59 INFO - 'LOGNAME': 'cltbld', 02:23:59 INFO - 'MAIL': '/var/mail/cltbld', 02:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:59 INFO - 'MOZ_NO_REMOTE': '1', 02:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:59 INFO - 'NO_EM_RESTART': '1', 02:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:59 INFO - 'PWD': '/builds/slave/test', 02:23:59 INFO - 'SHELL': '/bin/bash', 02:23:59 INFO - 'SHLVL': '1', 02:23:59 INFO - 'TERM': 'linux', 02:23:59 INFO - 'TMOUT': '86400', 02:23:59 INFO - 'USER': 'cltbld', 02:23:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', 02:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:59 INFO - '_': '/tools/buildbot/bin/python'} 02:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:24:02 INFO - Installing collected packages: mozsystemmonitor 02:24:02 INFO - Running setup.py install for mozsystemmonitor 02:24:02 INFO - Successfully installed mozsystemmonitor 02:24:02 INFO - Cleaning up... 02:24:02 INFO - Return code: 0 02:24:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:24:02 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')]} 02:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:02 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')]} 02:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:02 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c72566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81c0>, '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 0x10f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', '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 02:24:02 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==2.5.1'] in /builds/slave/test/build 02:24:02 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==2.5.1 02:24:02 INFO - Using env: {'DISPLAY': ':0', 02:24:02 INFO - 'HOME': '/home/cltbld', 02:24:02 INFO - 'LANG': 'en_US.UTF-8', 02:24:02 INFO - 'LANGUAGE': 'en_US:en', 02:24:02 INFO - 'LOGNAME': 'cltbld', 02:24:02 INFO - 'MAIL': '/var/mail/cltbld', 02:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:02 INFO - 'MOZ_NO_REMOTE': '1', 02:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:02 INFO - 'NO_EM_RESTART': '1', 02:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:02 INFO - 'PWD': '/builds/slave/test', 02:24:02 INFO - 'SHELL': '/bin/bash', 02:24:02 INFO - 'SHLVL': '1', 02:24:02 INFO - 'TERM': 'linux', 02:24:02 INFO - 'TMOUT': '86400', 02:24:02 INFO - 'USER': 'cltbld', 02:24:02 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', 02:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:02 INFO - '_': '/tools/buildbot/bin/python'} 02:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:02 INFO - Downloading/unpacking jsonschema==2.5.1 02:24:02 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 02:24:02 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 02:24:02 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 02:24:02 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 02:24:02 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 02:24:02 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 02:24:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:24:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:24:04 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 02:24:04 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 02:24:04 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 02:24:04 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 02:24:04 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 02:24:04 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 02:24:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:24:04 INFO - warning: no files found matching '*.txt' 02:24:04 INFO - no previously-included directories found matching 'build' 02:24:04 INFO - no previously-included directories found matching 'dist' 02:24:04 INFO - no previously-included directories found matching '.git*' 02:24:04 INFO - Installing collected packages: jsonschema, functools32 02:24:04 INFO - Running setup.py install for functools32 02:24:04 INFO - warning: no files found matching '*.txt' 02:24:04 INFO - no previously-included directories found matching 'build' 02:24:04 INFO - no previously-included directories found matching 'dist' 02:24:04 INFO - no previously-included directories found matching '.git*' 02:24:04 INFO - Successfully installed jsonschema functools32 02:24:04 INFO - Cleaning up... 02:24:04 INFO - Return code: 0 02:24:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:04 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 0x7f4c72566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81c0>, '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 0x10f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', '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 02:24:04 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 02:24:04 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 02:24:04 INFO - Using env: {'DISPLAY': ':0', 02:24:04 INFO - 'HOME': '/home/cltbld', 02:24:04 INFO - 'LANG': 'en_US.UTF-8', 02:24:04 INFO - 'LANGUAGE': 'en_US:en', 02:24:04 INFO - 'LOGNAME': 'cltbld', 02:24:04 INFO - 'MAIL': '/var/mail/cltbld', 02:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:04 INFO - 'MOZ_NO_REMOTE': '1', 02:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:04 INFO - 'NO_EM_RESTART': '1', 02:24:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:04 INFO - 'PWD': '/builds/slave/test', 02:24:04 INFO - 'SHELL': '/bin/bash', 02:24:04 INFO - 'SHLVL': '1', 02:24:04 INFO - 'TERM': 'linux', 02:24:04 INFO - 'TMOUT': '86400', 02:24:04 INFO - 'USER': 'cltbld', 02:24:04 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', 02:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:04 INFO - '_': '/tools/buildbot/bin/python'} 02:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:04 INFO - Downloading/unpacking blobuploader==1.2.4 02:24:04 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 02:24:04 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 02:24:04 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 02:24:04 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 02:24:04 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 02:24:04 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 02:24:06 INFO - Downloading blobuploader-1.2.4.tar.gz 02:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:24:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:24:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:07 INFO - Downloading docopt-0.6.1.tar.gz 02:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:24:07 INFO - Installing collected packages: blobuploader, requests, docopt 02:24:07 INFO - Running setup.py install for blobuploader 02:24:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:24:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:24:07 INFO - Running setup.py install for requests 02:24:08 INFO - Running setup.py install for docopt 02:24:08 INFO - Successfully installed blobuploader requests docopt 02:24:08 INFO - Cleaning up... 02:24:08 INFO - Return code: 0 02:24:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:08 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 0x7f4c72566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81c0>, '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 0x10f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', '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 02:24:08 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 02:24:08 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 02:24:08 INFO - Using env: {'DISPLAY': ':0', 02:24:08 INFO - 'HOME': '/home/cltbld', 02:24:08 INFO - 'LANG': 'en_US.UTF-8', 02:24:08 INFO - 'LANGUAGE': 'en_US:en', 02:24:08 INFO - 'LOGNAME': 'cltbld', 02:24:08 INFO - 'MAIL': '/var/mail/cltbld', 02:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:08 INFO - 'MOZ_NO_REMOTE': '1', 02:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:08 INFO - 'NO_EM_RESTART': '1', 02:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:08 INFO - 'PWD': '/builds/slave/test', 02:24:08 INFO - 'SHELL': '/bin/bash', 02:24:08 INFO - 'SHLVL': '1', 02:24:08 INFO - 'TERM': 'linux', 02:24:08 INFO - 'TMOUT': '86400', 02:24:08 INFO - 'USER': 'cltbld', 02:24:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', 02:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:08 INFO - '_': '/tools/buildbot/bin/python'} 02:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:08 INFO - Running setup.py (path:/tmp/pip-FfCCVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:08 INFO - Running setup.py (path:/tmp/pip-dA9AC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:08 INFO - Running setup.py (path:/tmp/pip-foeZ7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:08 INFO - Running setup.py (path:/tmp/pip-fOwWeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:24:08 INFO - Running setup.py (path:/tmp/pip-tXsvNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:24:08 INFO - Running setup.py (path:/tmp/pip-cRG33S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:24:08 INFO - Running setup.py (path:/tmp/pip-VXDc6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:24:08 INFO - Running setup.py (path:/tmp/pip-xHfNHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:24:09 INFO - Running setup.py (path:/tmp/pip-_nNrRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:24:09 INFO - Running setup.py (path:/tmp/pip-Ex0Ez1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:24:09 INFO - Running setup.py (path:/tmp/pip-NuPtDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:24:09 INFO - Running setup.py (path:/tmp/pip-nLHS9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:24:09 INFO - Running setup.py (path:/tmp/pip-gFiF7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:24:09 INFO - Running setup.py (path:/tmp/pip-Z0ZwQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:09 INFO - Running setup.py (path:/tmp/pip-xD6ROC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:24:09 INFO - Running setup.py (path:/tmp/pip-2sDCCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:24:09 INFO - Running setup.py (path:/tmp/pip-pS_7dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:24:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:24:09 INFO - Running setup.py install for manifestparser 02:24:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:24:09 INFO - Running setup.py install for mozcrash 02:24:09 INFO - Running setup.py install for mozdebug 02:24:09 INFO - Running setup.py install for mozdevice 02:24:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Running setup.py install for mozfile 02:24:10 INFO - Running setup.py install for mozhttpd 02:24:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Running setup.py install for mozinfo 02:24:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Running setup.py install for mozInstall 02:24:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Running setup.py install for mozleak 02:24:10 INFO - Running setup.py install for mozlog 02:24:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Running setup.py install for moznetwork 02:24:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Running setup.py install for mozprocess 02:24:10 INFO - Running setup.py install for mozprofile 02:24:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:24:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:24:11 INFO - Running setup.py install for mozrunner 02:24:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:24:11 INFO - Running setup.py install for mozscreenshot 02:24:11 INFO - Running setup.py install for moztest 02:24:11 INFO - Running setup.py install for mozversion 02:24:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:24:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:24:11 INFO - Cleaning up... 02:24:11 INFO - Return code: 0 02:24:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:11 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 0x7f4c72566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81c0>, '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 0x10f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', '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 02:24:11 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 02:24:11 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 02:24:11 INFO - Using env: {'DISPLAY': ':0', 02:24:11 INFO - 'HOME': '/home/cltbld', 02:24:11 INFO - 'LANG': 'en_US.UTF-8', 02:24:11 INFO - 'LANGUAGE': 'en_US:en', 02:24:11 INFO - 'LOGNAME': 'cltbld', 02:24:11 INFO - 'MAIL': '/var/mail/cltbld', 02:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:11 INFO - 'MOZ_NO_REMOTE': '1', 02:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:11 INFO - 'NO_EM_RESTART': '1', 02:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:11 INFO - 'PWD': '/builds/slave/test', 02:24:11 INFO - 'SHELL': '/bin/bash', 02:24:11 INFO - 'SHLVL': '1', 02:24:11 INFO - 'TERM': 'linux', 02:24:11 INFO - 'TMOUT': '86400', 02:24:11 INFO - 'USER': 'cltbld', 02:24:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', 02:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:11 INFO - '_': '/tools/buildbot/bin/python'} 02:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:11 INFO - Running setup.py (path:/tmp/pip-Xi0KID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:11 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)) 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:11 INFO - Running setup.py (path:/tmp/pip-AgUQxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:11 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)) 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:11 INFO - Running setup.py (path:/tmp/pip-INRB3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:11 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)) 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:11 INFO - Running setup.py (path:/tmp/pip-MBmj_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:24:11 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)) 02:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:24:11 INFO - Running setup.py (path:/tmp/pip-7fe88N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:24:12 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:24:12 INFO - Running setup.py (path:/tmp/pip-Ju3UGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:24:12 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:24:12 INFO - Running setup.py (path:/tmp/pip-5ixUep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:24:12 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:24:12 INFO - Running setup.py (path:/tmp/pip-obamx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:24:12 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:24:12 INFO - Running setup.py (path:/tmp/pip-RHpF_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:24:12 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:24:12 INFO - Running setup.py (path:/tmp/pip-ero0Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:24:12 INFO - Running setup.py (path:/tmp/pip-jvmEgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:24:12 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:24:12 INFO - Running setup.py (path:/tmp/pip-P_F9KF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:24:12 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:24:12 INFO - Running setup.py (path:/tmp/pip-eL0HU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:24:12 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:24:12 INFO - Running setup.py (path:/tmp/pip-I1Vtie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:24:12 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:12 INFO - Running setup.py (path:/tmp/pip-QXqsAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:12 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:24:12 INFO - Running setup.py (path:/tmp/pip-q3YzpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:24:12 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)) 02:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:24:12 INFO - Running setup.py (path:/tmp/pip-B7xkXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:24:12 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)) 02:24:12 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)) 02:24:12 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)) 02:24:12 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)) 02:24:12 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)) 02:24:12 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)) 02:24:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:14 INFO - Downloading blessings-1.6.tar.gz 02:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:24:14 INFO - Installing collected packages: blessings 02:24:14 INFO - Running setup.py install for blessings 02:24:15 INFO - Successfully installed blessings 02:24:15 INFO - Cleaning up... 02:24:15 INFO - Return code: 0 02:24:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:24:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:24:15 INFO - Reading from file tmpfile_stdout 02:24:15 INFO - Current package versions: 02:24:15 INFO - argparse == 1.2.1 02:24:15 INFO - blessings == 1.6 02:24:15 INFO - blobuploader == 1.2.4 02:24:15 INFO - docopt == 0.6.1 02:24:15 INFO - functools32 == 3.2.3-2 02:24:15 INFO - jsonschema == 2.5.1 02:24:15 INFO - manifestparser == 1.1 02:24:15 INFO - mozInstall == 1.12 02:24:15 INFO - mozcrash == 0.17 02:24:15 INFO - mozdebug == 0.1 02:24:15 INFO - mozdevice == 0.48 02:24:15 INFO - mozfile == 1.2 02:24:15 INFO - mozhttpd == 0.7 02:24:15 INFO - mozinfo == 0.9 02:24:15 INFO - mozleak == 0.1 02:24:15 INFO - mozlog == 3.2 02:24:15 INFO - moznetwork == 0.27 02:24:15 INFO - mozprocess == 0.22 02:24:15 INFO - mozprofile == 0.28 02:24:15 INFO - mozrunner == 6.11 02:24:15 INFO - mozscreenshot == 0.1 02:24:15 INFO - mozsystemmonitor == 0.3 02:24:15 INFO - moztest == 0.7 02:24:15 INFO - mozversion == 1.4 02:24:15 INFO - psutil == 3.1.1 02:24:15 INFO - requests == 1.2.3 02:24:15 INFO - wsgiref == 0.1.2 02:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:15 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 0x7f4c72566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81c0>, '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 0x10f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', '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 02:24:15 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 02:24:15 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 02:24:15 INFO - Using env: {'DISPLAY': ':0', 02:24:15 INFO - 'HOME': '/home/cltbld', 02:24:15 INFO - 'LANG': 'en_US.UTF-8', 02:24:15 INFO - 'LANGUAGE': 'en_US:en', 02:24:15 INFO - 'LOGNAME': 'cltbld', 02:24:15 INFO - 'MAIL': '/var/mail/cltbld', 02:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:15 INFO - 'MOZ_NO_REMOTE': '1', 02:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:15 INFO - 'NO_EM_RESTART': '1', 02:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:15 INFO - 'PWD': '/builds/slave/test', 02:24:15 INFO - 'SHELL': '/bin/bash', 02:24:15 INFO - 'SHLVL': '1', 02:24:15 INFO - 'TERM': 'linux', 02:24:15 INFO - 'TMOUT': '86400', 02:24:15 INFO - 'USER': 'cltbld', 02:24:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', 02:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:15 INFO - '_': '/tools/buildbot/bin/python'} 02:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:15 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)) 02:24:15 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)) 02:24:15 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)) 02:24:15 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)) 02:24:15 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)) 02:24:15 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)) 02:24:15 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)) 02:24:15 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)) 02:24:15 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)) 02:24:15 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)) 02:24:15 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)) 02:24:15 INFO - Cleaning up... 02:24:15 INFO - Return code: 0 02:24:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:15 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 0x7f4c72566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81c0>, '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 0x10f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', '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 02:24:15 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 02:24:15 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 02:24:15 INFO - Using env: {'DISPLAY': ':0', 02:24:15 INFO - 'HOME': '/home/cltbld', 02:24:15 INFO - 'LANG': 'en_US.UTF-8', 02:24:15 INFO - 'LANGUAGE': 'en_US:en', 02:24:15 INFO - 'LOGNAME': 'cltbld', 02:24:15 INFO - 'MAIL': '/var/mail/cltbld', 02:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:15 INFO - 'MOZ_NO_REMOTE': '1', 02:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:15 INFO - 'NO_EM_RESTART': '1', 02:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:15 INFO - 'PWD': '/builds/slave/test', 02:24:15 INFO - 'SHELL': '/bin/bash', 02:24:15 INFO - 'SHLVL': '1', 02:24:15 INFO - 'TERM': 'linux', 02:24:15 INFO - 'TMOUT': '86400', 02:24:15 INFO - 'USER': 'cltbld', 02:24:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', 02:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:15 INFO - '_': '/tools/buildbot/bin/python'} 02:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:24:15 INFO - Cleaning up... 02:24:15 INFO - Return code: 0 02:24:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:15 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 0x7f4c72566f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81c0>, '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 0x10f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', '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 02:24:15 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 02:24:15 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 02:24:15 INFO - Using env: {'DISPLAY': ':0', 02:24:15 INFO - 'HOME': '/home/cltbld', 02:24:15 INFO - 'LANG': 'en_US.UTF-8', 02:24:15 INFO - 'LANGUAGE': 'en_US:en', 02:24:15 INFO - 'LOGNAME': 'cltbld', 02:24:15 INFO - 'MAIL': '/var/mail/cltbld', 02:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:15 INFO - 'MOZ_NO_REMOTE': '1', 02:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:15 INFO - 'NO_EM_RESTART': '1', 02:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:15 INFO - 'PWD': '/builds/slave/test', 02:24:15 INFO - 'SHELL': '/bin/bash', 02:24:15 INFO - 'SHLVL': '1', 02:24:15 INFO - 'TERM': 'linux', 02:24:15 INFO - 'TMOUT': '86400', 02:24:15 INFO - 'USER': 'cltbld', 02:24:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', 02:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:15 INFO - '_': '/tools/buildbot/bin/python'} 02:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:15 INFO - Downloading/unpacking flake8 02:24:15 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 02:24:15 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 02:24:15 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 02:24:15 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 02:24:15 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 02:24:15 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 02:24:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:24:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:24:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:24:18 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 02:24:18 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 02:24:18 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 02:24:18 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 02:24:18 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 02:24:18 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 02:24:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:24:18 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 02:24:18 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 02:24:18 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 02:24:18 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 02:24:18 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 02:24:18 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 02:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:24:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:18 INFO - no previously-included directories found matching 'docs/_build' 02:24:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:24:18 INFO - Running setup.py install for pep8 02:24:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:18 INFO - no previously-included directories found matching 'docs/_build' 02:24:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:24:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:24:18 INFO - Cleaning up... 02:24:18 INFO - Return code: 0 02:24:18 INFO - Running post-action listener: _resource_record_post_action 02:24:18 INFO - Running post-action listener: _start_resource_monitoring 02:24:18 INFO - Starting resource monitoring. 02:24:18 INFO - ##### 02:24:18 INFO - ##### Finished create-virtualenv step (success) 02:24:18 INFO - ##### 02:24:18 INFO - ##### 02:24:18 INFO - ##### Running install step. 02:24:18 INFO - ##### 02:24:18 INFO - Running pre-action listener: _resource_record_pre_action 02:24:18 INFO - Running main action method: install 02:24:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:24:19 INFO - Reading from file tmpfile_stdout 02:24:19 INFO - Detecting whether we're running mozinstall >=1.0... 02:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:24:19 INFO - Reading from file tmpfile_stdout 02:24:19 INFO - Output received: 02:24:19 INFO - Usage: mozinstall [options] installer 02:24:19 INFO - Options: 02:24:19 INFO - -h, --help show this help message and exit 02:24:19 INFO - -d DEST, --destination=DEST 02:24:19 INFO - Directory to install application into. [default: 02:24:19 INFO - "/builds/slave/test"] 02:24:19 INFO - --app=APP Application being installed. [default: firefox] 02:24:19 INFO - mkdir: /builds/slave/test/build/application 02:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:24:36 INFO - Reading from file tmpfile_stdout 02:24:36 INFO - Output received: 02:24:36 INFO - /builds/slave/test/build/application/firefox/firefox 02:24:36 INFO - Running post-action listener: _resource_record_post_action 02:24:36 INFO - ##### 02:24:36 INFO - ##### Finished install step (success) 02:24:36 INFO - ##### 02:24:36 INFO - ##### 02:24:36 INFO - ##### Running run-tests step. 02:24:36 INFO - ##### 02:24:36 INFO - Running pre-action listener: _resource_record_pre_action 02:24:36 INFO - Running main action method: run_tests 02:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:24:36 INFO - Python 2.7.3 02:24:36 INFO - Return code: 0 02:24:36 INFO - grabbing minidump binary from tooltool 02:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:36 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81c0>, '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 0x10f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:24:36 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 02:24:36 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 02:24:36 INFO - Calling ['/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'] with output_timeout 600 02:24:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:24:36 INFO - Return code: 0 02:24:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:24:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:24:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:24:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:24:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:24:37 INFO - Return code: 0 02:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 02:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 02:24:37 INFO - Using env: {'DISPLAY': ':0', 02:24:37 INFO - 'HOME': '/home/cltbld', 02:24:37 INFO - 'LANG': 'en_US.UTF-8', 02:24:37 INFO - 'LANGUAGE': 'en_US:en', 02:24:37 INFO - 'LOGNAME': 'cltbld', 02:24:37 INFO - 'MAIL': '/var/mail/cltbld', 02:24:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:24:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:37 INFO - 'MOZ_NO_REMOTE': '1', 02:24:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:37 INFO - 'NO_EM_RESTART': '1', 02:24:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:37 INFO - 'PWD': '/builds/slave/test', 02:24:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:24:37 INFO - 'SHELL': '/bin/bash', 02:24:37 INFO - 'SHLVL': '1', 02:24:37 INFO - 'TERM': 'linux', 02:24:37 INFO - 'TMOUT': '86400', 02:24:37 INFO - 'USER': 'cltbld', 02:24:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673', 02:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:37 INFO - '_': '/tools/buildbot/bin/python'} 02:24:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 02:24:37 INFO - mozversion application_buildid: 20160622233407 02:24:37 INFO - mozversion application_changeset: fd26cef5ff88205d6cb3896996c45f36ec305d8b 02:24:37 INFO - mozversion application_display_name: Nightly 02:24:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:24:37 INFO - mozversion application_name: Firefox 02:24:37 INFO - mozversion application_remotingname: firefox 02:24:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:24:37 INFO - mozversion application_vendor: Mozilla 02:24:37 INFO - mozversion application_version: 50.0a1 02:24:37 INFO - mozversion platform_buildid: 20160622233407 02:24:37 INFO - mozversion platform_changeset: fd26cef5ff88205d6cb3896996c45f36ec305d8b 02:24:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:24:37 INFO - mozversion platform_version: 50.0a1 02:24:37 INFO - using testdate: 1466673877 02:24:37 INFO - actual date: 1466673877 02:24:37 INFO - starting webserver on 'localhost:43835' 02:24:37 INFO - SUITE-START | Running 2 tests 02:24:37 INFO - TEST-START | dromaeo_css 02:24:37 INFO - operating with platform_type : linux_ 02:24:37 INFO - Initialising browser for dromaeo_css test... 02:24:37 INFO - TEST-INFO | started process 10302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYq1lTp/profile http://localhost:43835/getInfo.html) 02:24:41 INFO - PROCESS | 10302 | __metrics Screen width/height:1600/1200 02:24:41 INFO - PROCESS | 10302 | colorDepth:24 02:24:41 INFO - PROCESS | 10302 | Browser inner width/height: 1024/697 02:24:41 INFO - PROCESS | 10302 | __metrics 02:24:42 INFO - PROCESS | 10302 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:24:43 INFO - TEST-INFO | 10302: exit 0 02:24:43 INFO - Browser initialized. 02:24:43 INFO - Running cycle 1/1 for dromaeo_css test... 02:24:43 INFO - TEST-INFO | started process 10387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYq1lTp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:24:55 INFO - PROCESS | 10387 | RSS: Main: 174493696 02:24:55 INFO - PROCESS | 10387 | 02:25:47 INFO - PROCESS | 10387 | 1466673947269 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] 02:27:54 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:43835/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43835/tests/dromaeo/cssquery-ext.html) 02:27:56 INFO - PROCESS | 10387 | RSS: Main: 300281856 02:27:56 INFO - PROCESS | 10387 | 02:30:58 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:43835/tests/dromaeo/cssquery-ext.html (next: http://localhost:43835/tests/dromaeo/cssquery-jquery.html) 02:30:59 INFO - PROCESS | 10387 | RSS: Main: 263487488 02:30:59 INFO - PROCESS | 10387 | 02:34:01 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:43835/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43835/tests/dromaeo/cssquery-mootools.html) 02:34:01 INFO - PROCESS | 10387 | RSS: Main: 264921088 02:34:01 INFO - PROCESS | 10387 | 02:37:03 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:43835/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43835/tests/dromaeo/cssquery-prototype.html) 02:37:04 INFO - PROCESS | 10387 | RSS: Main: 258101248 02:37:04 INFO - PROCESS | 10387 | 02:40:06 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:43835/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43835/tests/dromaeo/cssquery-yui.html) 02:40:07 INFO - PROCESS | 10387 | RSS: Main: 246480896 02:40:07 INFO - PROCESS | 10387 | 02:43:10 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:43835/tests/dromaeo/cssquery-yui.html (next: http://localhost:43835/tests/dromaeo/cssquery-dojo.html) 02:43:10 INFO - PROCESS | 10387 | RSS: Main: 322846720 02:43:10 INFO - PROCESS | 10387 | 02:43:10 INFO - PROCESS | 10387 | __start_tp_report 02:43:10 INFO - PROCESS | 10387 | _x_x_mozilla_page_load 02:43:10 INFO - PROCESS | 10387 | _x_x_mozilla_page_load_details 02:43:10 INFO - PROCESS | 10387 | |i|pagename|runs| 02:43:10 INFO - PROCESS | 10387 | |0;dojo.html;3068.831214283215;3077.5229839374897;3092.8453577321134;3117.485614873546;3130.827804470753;5133.3326667533165;5202.661826981243;5206.453322401146;5285.101532739434;5308.203769434586;5251.86870328242;5256.947430525704;5258.973705131469;5354.170103633934;5390.164524498709;4735.076660051292;4810.470848206694;4818.807247710088;4827.782749776251;4985.302057711905;4885.804567817283;4896.534829191221;4904.386951631046;4955.182394904837;4962.255661650745;4604.378408914804;4712.222483290253;4761.809527618909;4782.736949467778;4785;4770.689905156154;4797.544233297831;4849.587785038276;4854.247591623269;4893.559579637849;4622.468416132154;4787.186178349689;4800.423949126092;4831;4862.197737373329;5195.610329225286;5283.63014588979;5289.788408463657;5361.035013697533;5386.192071189353;5700.116481945263;5722.484976352107;5746.827595172152;5751.482366587027;5751.539876809845;5460.34475862899;5609.831705048855;5699.344575373843;5723.828285151452;5724.914126288068;5309.707966061865;5368.785248590091;5388.380336261302;5397.919031214535;5405.756740946627;5848.736806843703;5850.3272123705465;5850.795222167204;5852.912206316909;5862.413758624103;5462.180672899018;5469.343678758574;5521.723913804293;5624.437556244343;5633.8309850704545;5645.040343141676;5680.715964201773;5686.232358631614;5690.829275121753;5696.145578163226;5606.579506536945;5612.35457922336;5613.803516876889;5619.297587801525;5619.634723742944;5465.289512363367;5584.888302233932;5625;5625.324961004706;5645.576581756384;4347.586979236968;4348.34774783785;4349.28236840924;4349.325854492558;4377.649788016951;3884.9805750971063;3896.7077469189926;3903.6681882039775;3934.6065393460426;3957.0107473131716;5260.9736951315;5281.287026251483;5319.494648008433;5325.4142044375085;5346.358436987586;5669.121286200645;5675.432456754292;5692.743826527816;5708.257926469532;5735.7418916148035;5391.379991301051;5396.487333703292;5399.406065332811;5404.8108316208745;5412.512873841373;4787.497312782108;4843.128236917319;4898.90202195954;4911.3369695090705;4953.1332016896895;5792.044312688444;5875.383084776123;5917.31950825652;5919.704014799243;5921;5680.091185410314;5681.4034526374135;5687.459691329317;5689.886202276014;5692.857678558069;5651.943480565142;5786.826395208151;5802.274715660543;5847.561432892465;5851.034579294369;5528.806491772769;5575.275214222125;5612.102063669793;5636.661800291996;5642.492175704207;5689.800856969986;5713.257276554022;5720.399358067343;5727.713614319351;5739.512141468022;5377.623566350318;5501.092319767194;5535.723213839373;5547.084731019498;5551.195076713934;5553.305836770403;5578.3584887738425;5583;5588.105903055492;5645.71771411436;5433.864153396196;5469.972650136724;5482.369527504228;5487.094629386106;5487.231787549826;5455.618106732491;5482.945170548243;5556.222128901876;5629.352624448241;5662.433756624305;5453.127499600045;5455.699936503531;5461.945380546303;5462.8907421850545;5499.752511137089 02:43:10 INFO - PROCESS | 10387 | |1;ext.html;542.0654818795913;572.49620334106;585.9882802343952;598.0700011482146;600.4025994135835;26847.463050739;35499.822500887494;36615.81692091542;36624.81687591565;36663;36741;37030.62969370312;37092.81453592728;37134.8143259284;37140.81429592848;8500.404971651988;8644.65421383144;8647;8648.135186481333;8675.26260267878;8436.704715334965;8552.059273479912;8554.315654747605;8555.230029297392;8559.144085591422;8605.870911936294;8625.870611940794;8640.2223799858;8644.481331120152;8645.049044605088;8558.657653693845;8594.742157735278;8599.398042137052;8603.526806025666;8604.440711353773;8445.155484451567;8524.10496897823;8526.957365213197;8533.317334613279;8536.70121545743;35628.82185589056;35890.461643075374;35918.64081359179;35929.46105808415;35951.820240898625;3153.2905096353365;3185.5540224368606;3228.2736384313575;3257.8533965971587;3529.1710540104978;28277.858610707022;28567.714322856715;28702.425951480855;28832;29900.700992990227;4019.718619696622;4020.43713880057;4029.1538776856896;4060.654844338235;4061.5341806870756;329528;330210;331024;331202.3439882809;332191;45222.77388613036;45271.77364113224;45616.54383456123;45652;45655;43749.34375984363;46740.29889551659;47662.523374766504;47667.523324767004;47727;14249.572512824632;14354.138751674933;14363.353649085817;14395.496157634641;14406.567802965928;10893.509792059376;10944.835827462595;10958.452077396258;10959.616413425492;10980.231383803057;12324.137310388187;13043.543475978295;13126.474941002252;13423;13643.863561364458;5052.368453943257;5189.818356357509;5197.610179236573;5217.947820521822;5245.580353571705;834.2491757418372;927.2211342472356;937.4469063252714;957.3729207369184;1021.1116328793848;27859.303517412227;27991.860040699667;28556.28609284743;28827.423451530853;28923;951.6145960885852;994.5027486256871;1012.8784545854397;1018.8930162332848;1020.4489575629077;14700.264986750833;14853.554393368217;14866.405343786344;15202.771958420633;15221.771673424908;512416;513186;517809;518743;519923;46409.30386044212;46606.300905486445;46633.53366466292;46653.83365415824;46741.5325846744;1049.459528342904;1126.7126882645036;1137.1528211482498;1161.1465572803982;1192.7435601345753;28181.71818281791;29070;29209.561856571745;29475;29688.703112968593;41013;41466.37800432936;41539.1692166161;41583;41590;376686;378173;378607;381512;389909;27972.440551188454;34035.65964340424;34393;35028;37321.81339093287;39622.02834787345;39729.80135099306;41157.588424115376;42562;43180.56819431765;35326.293474130885;36020.81989590035;36035;36193;36481.27037459289;34208.657913420546;34342.48486272658;34375.484367734;34619.30761384808;34658.306833862676;34172.31655366928;34225.315493689486;34395;34490.655093448746;34961.65038349685;30867.536986945663;32092.67907320897;32094.679053210104;32118.518222227154;32162;24764.133255335975;24842;25064.62403063992;25192.37019074538;25237.74762252354 02:43:10 INFO - PROCESS | 10387 | |2;jquery.html;353.71702637889683;354.485995306805;362.16701586351394;366.4905780964458;373.2590807247613;16901.57746056349;17697.82302176978;18755.53111172218;18757.812421875777;18782.154803033845;16061.759073613905;16657.750133747973;16935.3225870965;16951;16959.236834342453;5251.55361794248;5540.307461567304;5588.86027849305;5590.468905453975;5595.972020139893;4050.392441133824;4154.97922510387;4242.172776308621;5430.809921652743;6195.628262304253;6222.719977601018;6252.062190671413;6257.030160325134;6257.812265632016;6267.153934218868;6094.8781024379705;6132.938670613304;6219.906701399483;6232.688365581703;6243.719032643542;3611.476335931275;5074.974625126888;5426.2674538937135;5510.779568817243;5511.889762204733;18495.907520462446;18867.245310187576;19119.904400478048;21218.787812121835;21245.362639120696;2269.387265438339;2370.7747763962398;2374.8931298091456;2390.796782273509;2916.6354205724283;13181.209127452288;13509.527166549124;13753.106048106842;13851.445942162301;14091.78862317066;1920.7022911448748;1924.2303078768605;1939.2727727102338;1998.9000549972443;2060.3406909788873;72451;74788.25211747867;75976;76725.61637191834;77751;9480.155953214145;9599.568019439143;9630.133288004114;9795.608175672893;10024.448655323882;13119.475220991244;13188.406521706545;13235.602931912059;13285.335733213495;13290.534831280858;7708.2291770823595;7715.4599178058115;7816.7264145754625;7856.685732570633;7935.325497332791;7709.997700299037;7711.575863327571;7734.57459839703;7910.683572657029;7925.524468531907;5946.67293298864;6029.879402411927;6061.848453788691;6064.241969753781;6222.471089957314;1693.102655592538;1711.2213942656062;1715.2350590453834;1718.458685514084;1747.2574155983657;878.1481962496368;878.4202426398547;923.5151545438698;929.0755698080453;999.7700528878253;18074.367397141035;18660.066996650112;18777.436676899713;18796.718049229272;18925.43223703291;931.8509038553799;934.039096065474;956.364017928084;970.3304719743354;997.875265591801;9989.450580218157;10357.274990750575;10458.477076146315;10488.265821392582;10529.84205236922;423745;437576;461523;464773;466659;77156.61421692856;78420.64738057868;80063.59968200239;80416;80456.5977170122;896.2561074308309;934.7102398256699;948.037741692183;956.3353469338742;957.2150836314156;16448.259828307517;16851.24169412355;17075.658486829947;17096.145192740063;17169.313227471263;42258.57741422547;42547.3617895738;42870.78564607157;43663.56336436722;44744.77627611841;55616;55741;56759.14861277167;64563.35436645574;64950.35049649632;7948.721794737156;8149.573824580793;8245.093039765741;8342.040665323566;8903.554822258991;7712.8457430852195;9525.666406703205;12296.13031796216;13504.459821607026;13527;10846.403447810131;11082.944585277022;11157.330560166416;11274.887251127384;11632.185746997968;11305.43472826339;11372.829407558727;11381.54473821071;11556.248843825124;11657.18399712012;11464.94267528657;11708.765824683629;11829.585964491202;11891.167618266638;11960;7143.357097861218;7431.851362972819;7496.212897645887;7727.227277272228;8443.704470343508;10128.392296462236;11172.329660220414;11177.385243811668;11812.704682382666;11826.881731182579 02:43:10 INFO - PROCESS | 10387 | |3;mootools.html;1119.0264469911178;1159.2263836330417;1184.828199911013;1231.926084434934;1511.8488151184877;7952.085510166333;8248.505089694623;8275.420720549564;8523.360747943914;8532.8720069199;8181.100078991306;8350.83298334033;8360.749177524684;8362.832743345145;8381.455205411645;1982.692682634194;2164.2100633268824;2251.0995601759264;2281.7604151564055;2310.9653355199684;2278.5784629843533;2286.2683941138844;2290.438842483594;2290.7365652949957;2292.4727312718087;2281.7147856517936;2295.1393227539675;2313.3175713164655;2318.385627808632;2319.141917490531;1939.3987863762209;2183.410479170631;2256.5261295128043;2259.175400978639;2259.9661005084936;2220.877851718171;2257.7403598586206;2277.555876604063;2278.2140161644206;2280.486890449652;8611.095834937367;8785.34109941757;8789.340799440068;8791.868121978176;8793.384463087586;5075.543201111917;5222.738863056832;5226.372835259755;5228.2680424740565;5228.895422091575;3079.507278835398;3225.8064516129107;3287.5068739689;3302.2734998300575;3329.716974057208;1055.6358056470506;1064.9414282214475;1075.9892401075967;1077.95688172473;1082.9133669306436;12153.210041347284;12180.878191218064;12191.146619736623;12195.634130975996;12197.20718153326;4426.136903303889;4527.139843429738;4575.565321294472;4644.442666879996;4646.7444290564345;10210.591576336863;10237.846432303522;10241.48792560369;10243.282970192164;10245;5113.130767769489;5139.306193663882;5141.280220769096;5144.7942082316285;5178.792848286026;4119.196756632428;4536.274196128604;4667.883302917387;4693.624510039189;4797.136515427256;3664.340418724655;3744.8314825832904;3761.360568703327;3808.1050953026015;3834.6357096075826;1186.9643910682694;1187.6080893305189;1190.791611468007;1207.076586411396;1213.7754515414676;913.4291068082448;922.7785331520521;929.6188562689265;930.6649606141783;948.2366694810744;5652.519535839418;5680.699316776712;5836.517644241815;6009.849753756103;6021.488173505213;391.6925213707283;408.9120839019625;411.6151398442466;420.2288800051939;429.1224446007921;3912.7065470089856;4030.9798451008146;4031.637152656275;4036.6367026967714;4046.7976601170412;10704.09015233714;10751.731206719738;10994.560217591206;11057.281276716987;11089.27919685218;10891.727706807393;10948.507317170746;10986.066184374258;10991;10994.450277486094;8022.598870056474;8073.990751156223;8080.676772929134;8098.109207987117;8246.299064579578;5535.197396377423;5549.750261238173;5682.687452190169;5767.625104368202;5793.739281732416;10004.899951000689;10079.496025198858;10114.140298074746;10177.084062434416;10185.388876667128;10004.699859003951;10167;10439.164866810788;10446.373217606968;10521.579136834747;7329.083864516935;7545.962270188614;7581.393488520795;7582.090149182133;7744.225577442211;8518.063013068682;8552.743417697478;8596.613152408032;8604.139586041345;8606.870896936425;7065.682044307916;7284.053073100463;7293.52592081513;7360.263973602597;7425;7562.205968373241;7625.428092892944;7680.270374314431;7770.844583108419;7794.610269486389;6839.418649414855;6899;6913.239543650295;6913.654317284217;6925.549839260432;4937.975310123426;4955.331030310862;4966.155753521982;5150.948490515047;5197.7141257231215;5014.247862820606;5024.773885175103;5134.845954621367;5177.585793136464;5202.167653175474 02:43:10 INFO - PROCESS | 10387 | |4;prototype.html;295.66589753578467;312.92333378322314;314.5109354953048;315.846814295067;320.94383482890487;5312.973435132823;5348.438413966536;5371.5165635092835;5381;5385.545902606299;5000.7749651265685;5061.6709913855575;5236.764345604447;5300.337457817773;5302.708351040691;4142.896427589304;4171.374293855931;4186.937195942063;4196.286631272691;4196.769177695218;4152.667786577082;4178.579283043765;4187.7277976931555;4194.433751443562;4201.6008479194425;3890.8054597270166;3958.0896393829435;4064.9390259146135;4088.0393107619684;4161.7086803923585;4062.410950412174;4071.307877660805;4094.3858421236755;4152.231837110129;4157.210130075276;3596.7841929484052;3627.3470775260444;3638.43604241343;3647.4893514907667;3671.2657468506404;5103.668261562986;5130.589552835801;5188.45521220274;5196.64816193553;5206.479352064801;4678.532146785328;4684.601808846252;4714.83498077569;4729.668923175379;4739.3601863748645;5531.059719847635;5544.695041772701;5561.944380556183;5566.443355664442;5569.081101618228;3901.6200117928042;3959.6436320730986;3998.640122388999;4000.879973600797;4016.357382818735;5666.858328541819;5682.943170568283;5691.772329106872;5779.508741756956;5783.652980821164;4071.694622903294;4080.18396320737;4085.428040074392;4103.2409004334295;4120.979395103005;4020.1557672888434;4139.379093135994;4143.647789937889;4162.854300099482;4173.916521669549;4685.273782563708;4699.342092107107;4732.5977291929885;4739.810407583658;4742.264948932921;5576.86057848557;5578.86052848682;5588.972055139699;5648.915266271009;5657.010023245915;1379.7861331493634;1418.4609848257596;1439.3235179465635;1455.316001479303;1455.89080818939;876.6931573949067;886.7339798060556;892.9419587726777;1001.3541265883464;1002.9699109026741;5261.210818377198;5269.55208807248;5290.709011004432;5301.416844147141;5305.8938821223355;5505.339359276913;5659.830205093854;5705.429457054262;5720.513756330759;5720.971395143081;5308.92036619451;5314.28257185275;5327.840164795062;5344.835341686623;5364.544013758874;2974.2267010576975;2997.610310659644;3009.5485677148604;3012.2770535071427;3013.6986301370125;5565.41563135873;5787.826365209051;5814.912776308359;5844.532437404998;5847.970760146172;5650.576206784425;5702.8289151325525;5703.174984005162;5722.713864306768;5749.626274292241;5815.854603634858;5820.185174075633;5832.104566015977;5850.648961062265;5858.707064646751;5382.946170538245;5695.266272189289;5696.401877802771;5704.60067795267;5743.0811070228565;5644;5668.829935101789;5676.20533125371;5686.175504551734;5706.430731548691;5685.715714214355;5897.351291357862;5898.292204935264;5956.940430595639;5961.91057134152;4037.6783349573525;4063.7764922929523;4074.103697186614;4081.510218773766;4087.3051581230666;5747.367789543064;5748.109043098327;5751.022326204472;5753.827385178452;5795.392073566827;5472.972635136799;5596.076647353141;5607.8037268697035;5610.579206559442;5620.494155526022;5539.750711217925;5561;5561.916571251515;5564.33228012641;5626.690532020614;5208.583313335;5255.3168088148295;5432.891342173055;5489.451054894478;5493.450654934474;5632.436756324335;5632.5775566831835;5669.489745922887;5675.744591493475;5680.772769089355;5445.700486473282;5538.584606154635;5545.168224766156;5554.91667624994;5560.499555040065 02:43:10 INFO - PROCESS | 10387 | |5;yui.html;643.7010322099242;645.9095726598274;683.617174382346;698.7519430602136;724.2431658916433;13876.722465550683;14321.71356572868;14345.569632911016;14399.92800036001;14444.133351998875;12099.09256805741;12701.872981270184;12713.809292860591;12729.554465593683;12730.363481825918;652.4910569755574;762.6987340000696;776.809681628002;796.6176235406979;798.4251339035885;789.4237206839011;792.5086446403209;793.9007624046994;794.4161041634394;797.5015615240475;828.70580943765;829.3821103278066;830.0122853803954;830.4228561150003;831.0276975938167;526.8261473713684;786.8701664225367;814.9266566009028;816.1512027491402;822.5106061893164;594.6313285762811;594.6967046806117;595.4908553187006;595.7200115945542;600.471585005197;13550.728985420237;13591.116577422436;13598.116122452107;13655.317234138352;13720.245386503739;13749;13890;14017.158970461805;14231.430742770277;14439;12876.420561074774;12887.226766394046;13071.542496012595;13171.47314107444;13710.52013179544;4224.704270701052;4243.787810609457;4306.504751953534;4307.91384172318;4318.632916202127;76895;76923;77342;79094.604526977;79686;10713.410762407986;10754.838677419844;10784.260056434458;10974.396408197466;11087.113030957504;19164.71252931207;19170.04149792505;19178.328758493666;19217;19218.231270749013;8203.95898020518;8253;8332.375071869634;8402.915970840335;8582.699605513777;4410.051838854662;4508.864734057984;4531.524189960072;4553.142446603068;4671.416072990876;3514.525539052195;3640.8543658253375;3652.8538858445363;3658.268346330691;3658.304922064799;557.2588457351712;566.068653203506;608.3733754233147;625.0624063904144;626.2078470734433;554.7448173839998;644.8033349828347;656.5076192855358;657.947364210862;662.7084083003463;8983.955080224689;9031.63873445068;9445.66940157105;9495.477748723748;9683.709488715349;603.7856560920898;609.2262826210688;628.9465395441347;640.6540468147149;656.8062421585644;4296.9570304297185;4373.9125217495475;4464.397306363664;4510.864674059783;4631.637864688965;64006;65311.67344163249;128680;130241;133146;113407;114927;115470;116147;117168;91790;92067;92525.39768077781;95587.52206238924;96460.51769741246;8564.957175214084;8705.347098967477;8712.651493940171;8730.519821409884;8834.646614135363;54939.175912362145;55184.44815551793;55775.163372550254;56527.71736141457;57224.42775572191;72160.63919680368;85064.57467712622;86043.13956860351;86376;86447;11627.244229125079;12153.661749992683;12370.62888113358;12465.189762665397;13266.734665306447;12893.806592900926;13765.518206862711;13776.878370699646;13889.374978125807;14306.284685765462;9219.386607343555;11595.652130436101;12077.818832717341;12198.57304994321;12725.172863763826;13359.799603006157;13369.331533423096;13781.793273101111;13823.377947992565;14184.432622694976;13791.586252412444;13934;14004.36980335867;14102.435902563782;14435.78346324827;10737.463126843782;10930.781384372427;11065.944670276596;11172.106231501622;11249.30832157693;10246.53890574911;10976.725581860517;11082.501287442246;11554.27692765563;11773.117016223647 02:43:10 INFO - PROCESS | 10387 | __end_tp_report 02:43:10 INFO - PROCESS | 10387 | __start_cc_report 02:43:10 INFO - PROCESS | 10387 | _x_x_mozilla_cycle_collect,1029 02:43:10 INFO - PROCESS | 10387 | __end_cc_report 02:43:10 INFO - PROCESS | 10387 | __startTimestamp1466674990834__endTimestamp 02:43:10 INFO - PROCESS | 10387 | 02:43:10 INFO - PROCESS | 10387 | ------- Summary: start ------- 02:43:10 INFO - PROCESS | 10387 | Number of tests: 6 02:43:10 INFO - PROCESS | 10387 | 02:43:10 INFO - PROCESS | 10387 | [#0] dojo.html Cycles:165 Average:5269.03 Median:5462.18 stddev:591.68 (10.8%) stddev-sans-first:567.76 02:43:10 INFO - PROCESS | 10387 | Values: 3068.8 3077.5 3092.8 3117.5 3130.8 5133.3 5202.7 5206.5 5285.1 5308.2 5251.9 5256.9 5259.0 5354.2 5390.2 4735.1 4810.5 4818.8 4827.8 4985.3 4885.8 4896.5 4904.4 4955.2 4962.3 4604.4 4712.2 4761.8 4782.7 4785.0 4770.7 4797.5 4849.6 4854.2 4893.6 4622.5 4787.2 4800.4 4831.0 4862.2 5195.6 5283.6 5289.8 5361.0 5386.2 5700.1 5722.5 5746.8 5751.5 5751.5 5460.3 5609.8 5699.3 5723.8 5724.9 5309.7 5368.8 5388.4 5397.9 5405.8 5848.7 5850.3 5850.8 5852.9 5862.4 5462.2 5469.3 5521.7 5624.4 5633.8 5645.0 5680.7 5686.2 5690.8 5696.1 5606.6 5612.4 5613.8 5619.3 5619.6 5465.3 5584.9 5625.0 5625.3 5645.6 4347.6 4348.3 4349.3 4349.3 4377.6 3885.0 3896.7 3903.7 3934.6 3957.0 5261.0 5281.3 5319.5 5325.4 5346.4 5669.1 5675.4 5692.7 5708.3 5735.7 5391.4 5396.5 5399.4 5404.8 5412.5 4787.5 4843.1 4898.9 4911.3 4953.1 5792.0 5875.4 5917.3 5919.7 5921.0 5680.1 5681.4 5687.5 5689.9 5692.9 5651.9 5786.8 5802.3 5847.6 5851.0 5528.8 5575.3 5612.1 5636.7 5642.5 5689.8 5713.3 5720.4 5727.7 5739.5 5377.6 5501.1 5535.7 5547.1 5551.2 5553.3 5578.4 5583.0 5588.1 5645.7 5433.9 5470.0 5482.4 5487.1 5487.2 5455.6 5482.9 5556.2 5629.4 5662.4 5453.1 5455.7 5461.9 5462.9 5499.8 02:43:10 INFO - PROCESS | 10387 | 02:43:10 INFO - PROCESS | 10387 | [#1] ext.html Cycles:180 Average:54206.13 Median:36620.32 stddev:110778.64 (302.5%) stddev-sans-first:111016.13 02:43:10 INFO - PROCESS | 10387 | Values: 542.1 572.5 586.0 598.1 600.4 26847.5 35499.8 36615.8 36624.8 36663.0 36741.0 37030.6 37092.8 37134.8 37140.8 8500.4 8644.7 8647.0 8648.1 8675.3 8436.7 8552.1 8554.3 8555.2 8559.1 8605.9 8625.9 8640.2 8644.5 8645.0 8558.7 8594.7 8599.4 8603.5 8604.4 8445.2 8524.1 8527.0 8533.3 8536.7 35628.8 35890.5 35918.6 35929.5 35951.8 3153.3 3185.6 3228.3 3257.9 3529.2 28277.9 28567.7 28702.4 28832.0 29900.7 4019.7 4020.4 4029.2 4060.7 4061.5 329528.0 330210.0 331024.0 331202.3 332191.0 45222.8 45271.8 45616.5 45652.0 45655.0 43749.3 46740.3 47662.5 47667.5 47727.0 14249.6 14354.1 14363.4 14395.5 14406.6 10893.5 10944.8 10958.5 10959.6 10980.2 12324.1 13043.5 13126.5 13423.0 13643.9 5052.4 5189.8 5197.6 5217.9 5245.6 834.2 927.2 937.4 957.4 1021.1 27859.3 27991.9 28556.3 28827.4 28923.0 951.6 994.5 1012.9 1018.9 1020.4 14700.3 14853.6 14866.4 15202.8 15221.8 512416.0 513186.0 517809.0 518743.0 519923.0 46409.3 46606.3 46633.5 46653.8 46741.5 1049.5 1126.7 1137.2 1161.1 1192.7 28181.7 29070.0 29209.6 29475.0 29688.7 41013.0 41466.4 41539.2 41583.0 41590.0 376686.0 378173.0 378607.0 381512.0 389909.0 27972.4 34035.7 34393.0 35028.0 37321.8 39622.0 39729.8 41157.6 42562.0 43180.6 35326.3 36020.8 36035.0 36193.0 36481.3 34208.7 34342.5 34375.5 34619.3 34658.3 34172.3 34225.3 34395.0 34490.7 34961.7 30867.5 32092.7 32094.7 32118.5 32162.0 24764.1 24842.0 25064.6 25192.4 25237.7 02:43:10 INFO - PROCESS | 10387 | 02:43:10 INFO - PROCESS | 10387 | [#2] jquery.html Cycles:180 Average:27149.64 Median:43267.17 stddev:74326.61 (171.8%) stddev-sans-first:74507.88 02:43:10 INFO - PROCESS | 10387 | Values: 353.7 354.5 362.2 366.5 373.3 16901.6 17697.8 18755.5 18757.8 18782.2 16061.8 16657.8 16935.3 16951.0 16959.2 5251.6 5540.3 5588.9 5590.5 5596.0 4050.4 4155.0 4242.2 5430.8 6195.6 6222.7 6252.1 6257.0 6257.8 6267.2 6094.9 6132.9 6219.9 6232.7 6243.7 3611.5 5075.0 5426.3 5510.8 5511.9 18495.9 18867.2 19119.9 21218.8 21245.4 2269.4 2370.8 2374.9 2390.8 2916.6 13181.2 13509.5 13753.1 13851.4 14091.8 1920.7 1924.2 1939.3 1998.9 2060.3 72451.0 74788.3 75976.0 76725.6 77751.0 9480.2 9599.6 9630.1 9795.6 10024.4 13119.5 13188.4 13235.6 13285.3 13290.5 7708.2 7715.5 7816.7 7856.7 7935.3 7710.0 7711.6 7734.6 7910.7 7925.5 5946.7 6029.9 6061.8 6064.2 6222.5 1693.1 1711.2 1715.2 1718.5 1747.3 878.1 878.4 923.5 929.1 999.8 18074.4 18660.1 18777.4 18796.7 18925.4 931.9 934.0 956.4 970.3 997.9 9989.5 10357.3 10458.5 10488.3 10529.8 423745.0 437576.0 461523.0 464773.0 466659.0 77156.6 78420.6 80063.6 80416.0 80456.6 896.3 934.7 948.0 956.3 957.2 16448.3 16851.2 17075.7 17096.1 17169.3 42258.6 42547.4 42870.8 43663.6 44744.8 55616.0 55741.0 56759.1 64563.4 64950.4 7948.7 8149.6 8245.1 8342.0 8903.6 7712.8 9525.7 12296.1 13504.5 13527.0 10846.4 11082.9 11157.3 11274.9 11632.2 11305.4 11372.8 11381.5 11556.2 11657.2 11464.9 11708.8 11829.6 11891.2 11960.0 7143.4 7431.9 7496.2 7727.2 8443.7 10128.4 11172.3 11177.4 11812.7 11826.9 02:43:10 INFO - PROCESS | 10387 | 02:43:10 INFO - PROCESS | 10387 | [#3] mootools.html Cycles:180 Average:5679.28 Median:2427.63 stddev:3324.17 (136.9%) stddev-sans-first:3315.83 02:43:10 INFO - PROCESS | 10387 | Values: 1119.0 1159.2 1184.8 1231.9 1511.8 7952.1 8248.5 8275.4 8523.4 8532.9 8181.1 8350.8 8360.7 8362.8 8381.5 1982.7 2164.2 2251.1 2281.8 2311.0 2278.6 2286.3 2290.4 2290.7 2292.5 2281.7 2295.1 2313.3 2318.4 2319.1 1939.4 2183.4 2256.5 2259.2 2260.0 2220.9 2257.7 2277.6 2278.2 2280.5 8611.1 8785.3 8789.3 8791.9 8793.4 5075.5 5222.7 5226.4 5228.3 5228.9 3079.5 3225.8 3287.5 3302.3 3329.7 1055.6 1064.9 1076.0 1078.0 1082.9 12153.2 12180.9 12191.1 12195.6 12197.2 4426.1 4527.1 4575.6 4644.4 4646.7 10210.6 10237.8 10241.5 10243.3 10245.0 5113.1 5139.3 5141.3 5144.8 5178.8 4119.2 4536.3 4667.9 4693.6 4797.1 3664.3 3744.8 3761.4 3808.1 3834.6 1187.0 1187.6 1190.8 1207.1 1213.8 913.4 922.8 929.6 930.7 948.2 5652.5 5680.7 5836.5 6009.8 6021.5 391.7 408.9 411.6 420.2 429.1 3912.7 4031.0 4031.6 4036.6 4046.8 10704.1 10751.7 10994.6 11057.3 11089.3 10891.7 10948.5 10986.1 10991.0 10994.5 8022.6 8074.0 8080.7 8098.1 8246.3 5535.2 5549.8 5682.7 5767.6 5793.7 10004.9 10079.5 10114.1 10177.1 10185.4 10004.7 10167.0 10439.2 10446.4 10521.6 7329.1 7546.0 7581.4 7582.1 7744.2 8518.1 8552.7 8596.6 8604.1 8606.9 7065.7 7284.1 7293.5 7360.3 7425.0 7562.2 7625.4 7680.3 7770.8 7794.6 6839.4 6899.0 6913.2 6913.7 6925.5 4938.0 4955.3 4966.2 5150.9 5197.7 5014.2 5024.8 5134.8 5177.6 5202.2 02:43:10 INFO - PROCESS | 10387 | 02:43:10 INFO - PROCESS | 10387 | [#4] prototype.html Cycles:180 Average:4676.89 Median:5313.63 stddev:1375.90 (25.9%) stddev-sans-first:1339.89 02:43:10 INFO - PROCESS | 10387 | Values: 295.7 312.9 314.5 315.8 320.9 5313.0 5348.4 5371.5 5381.0 5385.5 5000.8 5061.7 5236.8 5300.3 5302.7 4142.9 4171.4 4186.9 4196.3 4196.8 4152.7 4178.6 4187.7 4194.4 4201.6 3890.8 3958.1 4064.9 4088.0 4161.7 4062.4 4071.3 4094.4 4152.2 4157.2 3596.8 3627.3 3638.4 3647.5 3671.3 5103.7 5130.6 5188.5 5196.6 5206.5 4678.5 4684.6 4714.8 4729.7 4739.4 5531.1 5544.7 5561.9 5566.4 5569.1 3901.6 3959.6 3998.6 4000.9 4016.4 5666.9 5682.9 5691.8 5779.5 5783.7 4071.7 4080.2 4085.4 4103.2 4121.0 4020.2 4139.4 4143.6 4162.9 4173.9 4685.3 4699.3 4732.6 4739.8 4742.3 5576.9 5578.9 5589.0 5648.9 5657.0 1379.8 1418.5 1439.3 1455.3 1455.9 876.7 886.7 892.9 1001.4 1003.0 5261.2 5269.6 5290.7 5301.4 5305.9 5505.3 5659.8 5705.4 5720.5 5721.0 5308.9 5314.3 5327.8 5344.8 5364.5 2974.2 2997.6 3009.5 3012.3 3013.7 5565.4 5787.8 5814.9 5844.5 5848.0 5650.6 5702.8 5703.2 5722.7 5749.6 5815.9 5820.2 5832.1 5850.6 5858.7 5382.9 5695.3 5696.4 5704.6 5743.1 5644.0 5668.8 5676.2 5686.2 5706.4 5685.7 5897.4 5898.3 5956.9 5961.9 4037.7 4063.8 4074.1 4081.5 4087.3 5747.4 5748.1 5751.0 5753.8 5795.4 5473.0 5596.1 5607.8 5610.6 5620.5 5539.8 5561.0 5561.9 5564.3 5626.7 5208.6 5255.3 5432.9 5489.5 5493.5 5632.4 5632.6 5669.5 5675.7 5680.8 5445.7 5538.6 5545.2 5554.9 5560.5 02:43:10 INFO - PROCESS | 10387 | 02:43:10 INFO - PROCESS | 10387 | [#5] yui.html Cycles:180 Average:21261.66 Median:4486.63 stddev:32037.28 (714.1%) stddev-sans-first:32089.74 02:43:10 INFO - PROCESS | 10387 | Values: 643.7 645.9 683.6 698.8 724.2 13876.7 14321.7 14345.6 14399.9 14444.1 12099.1 12701.9 12713.8 12729.6 12730.4 652.5 762.7 776.8 796.6 798.4 789.4 792.5 793.9 794.4 797.5 828.7 829.4 830.0 830.4 831.0 526.8 786.9 814.9 816.2 822.5 594.6 594.7 595.5 595.7 600.5 13550.7 13591.1 13598.1 13655.3 13720.2 13749.0 13890.0 14017.2 14231.4 14439.0 12876.4 12887.2 13071.5 13171.5 13710.5 4224.7 4243.8 4306.5 4307.9 4318.6 76895.0 76923.0 77342.0 79094.6 79686.0 10713.4 10754.8 10784.3 10974.4 11087.1 19164.7 19170.0 19178.3 19217.0 19218.2 8204.0 8253.0 8332.4 8402.9 8582.7 4410.1 4508.9 4531.5 4553.1 4671.4 3514.5 3640.9 3652.9 3658.3 3658.3 557.3 566.1 608.4 625.1 626.2 554.7 644.8 656.5 657.9 662.7 8984.0 9031.6 9445.7 9495.5 9683.7 603.8 609.2 628.9 640.7 656.8 4297.0 4373.9 4464.4 4510.9 4631.6 64006.0 65311.7 128680.0 130241.0 133146.0 113407.0 114927.0 115470.0 116147.0 117168.0 91790.0 92067.0 92525.4 95587.5 96460.5 8565.0 8705.3 8712.7 8730.5 8834.6 54939.2 55184.4 55775.2 56527.7 57224.4 72160.6 85064.6 86043.1 86376.0 86447.0 11627.2 12153.7 12370.6 12465.2 13266.7 12893.8 13765.5 13776.9 13889.4 14306.3 9219.4 11595.7 12077.8 12198.6 12725.2 13359.8 13369.3 13781.8 13823.4 14184.4 13791.6 13934.0 14004.4 14102.4 14435.8 10737.5 10930.8 11065.9 11172.1 11249.3 10246.5 10976.7 11082.5 11554.3 11773.1 02:43:10 INFO - PROCESS | 10387 | -------- Summary: end -------- 02:43:10 INFO - PROCESS | 10387 | 02:43:11 INFO - TEST-INFO | 10387: exit 0 02:43:11 INFO - TEST-OK | dromaeo_css | took 1114167ms 02:43:11 INFO - TEST-START | kraken 02:43:11 INFO - operating with platform_type : linux_ 02:43:11 INFO - Initialising browser for kraken test... 02:43:11 INFO - TEST-INFO | started process 10575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnHuXal/profile http://localhost:43835/getInfo.html) 02:43:15 INFO - PROCESS | 10575 | __metrics Screen width/height:1600/1200 02:43:15 INFO - PROCESS | 10575 | colorDepth:24 02:43:15 INFO - PROCESS | 10575 | Browser inner width/height: 1024/697 02:43:15 INFO - PROCESS | 10575 | __metrics 02:43:16 INFO - PROCESS | 10575 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:43:17 INFO - TEST-INFO | 10575: exit 0 02:43:17 INFO - Browser initialized. 02:43:17 INFO - Running cycle 1/1 for kraken test... 02:43:17 INFO - TEST-INFO | started process 10659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnHuXal/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:43:29 INFO - PROCESS | 10659 | RSS: Main: 174657536 02:43:29 INFO - PROCESS | 10659 | 02:43:31 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43835/tests/kraken/driver.html?testName=audio-beat-detection) 02:43:32 INFO - PROCESS | 10659 | RSS: Main: 233074688 02:43:32 INFO - PROCESS | 10659 | 02:43:35 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43835/tests/kraken/driver.html?testName=audio-dft) 02:43:36 INFO - PROCESS | 10659 | RSS: Main: 221712384 02:43:36 INFO - PROCESS | 10659 | 02:43:39 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43835/tests/kraken/driver.html?testName=audio-fft) 02:43:39 INFO - PROCESS | 10659 | RSS: Main: 287281152 02:43:39 INFO - PROCESS | 10659 | 02:43:41 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43835/tests/kraken/driver.html?testName=audio-oscillator) 02:43:42 INFO - PROCESS | 10659 | RSS: Main: 198422528 02:43:42 INFO - PROCESS | 10659 | 02:43:44 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43835/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:43:45 INFO - PROCESS | 10659 | RSS: Main: 202403840 02:43:45 INFO - PROCESS | 10659 | 02:43:48 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43835/tests/kraken/driver.html?testName=imaging-darkroom) 02:43:48 INFO - PROCESS | 10659 | RSS: Main: 236212224 02:43:48 INFO - PROCESS | 10659 | 02:43:52 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43835/tests/kraken/driver.html?testName=imaging-desaturate) 02:43:52 INFO - PROCESS | 10659 | RSS: Main: 238497792 02:43:52 INFO - PROCESS | 10659 | 02:43:55 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43835/tests/kraken/driver.html?testName=json-parse-financial) 02:43:56 INFO - PROCESS | 10659 | RSS: Main: 238239744 02:43:56 INFO - PROCESS | 10659 | 02:43:57 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43835/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:43:58 INFO - PROCESS | 10659 | RSS: Main: 225599488 02:43:58 INFO - PROCESS | 10659 | 02:44:00 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43835/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:44:00 INFO - PROCESS | 10659 | RSS: Main: 230916096 02:44:00 INFO - PROCESS | 10659 | 02:44:02 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43835/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:44:03 INFO - PROCESS | 10659 | RSS: Main: 238465024 02:44:03 INFO - PROCESS | 10659 | 02:44:06 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:44:06 INFO - PROCESS | 10659 | RSS: Main: 240971776 02:44:06 INFO - PROCESS | 10659 | 02:44:09 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:44:10 INFO - PROCESS | 10659 | RSS: Main: 242020352 02:44:10 INFO - PROCESS | 10659 | 02:44:11 INFO - PROCESS | 10659 | Cycle 1(1): loaded http://localhost:43835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43835/tests/kraken/driver.html?testName=ai-astar) 02:44:11 INFO - PROCESS | 10659 | RSS: Main: 285130752 02:44:11 INFO - PROCESS | 10659 | 02:44:11 INFO - PROCESS | 10659 | __start_tp_report 02:44:11 INFO - PROCESS | 10659 | _x_x_mozilla_page_load 02:44:11 INFO - PROCESS | 10659 | _x_x_mozilla_page_load_details 02:44:11 INFO - PROCESS | 10659 | |i|pagename|runs| 02:44:11 INFO - PROCESS | 10659 | |0;ai-astar;100;111;111;109;109;109;110;110;112;110 02:44:11 INFO - PROCESS | 10659 | |1;audio-beat-detection;154;125;125;173;124;127;163;126;208;125 02:44:11 INFO - PROCESS | 10659 | |2;audio-dft;160;160;161;161;160;161;161;162;163;161 02:44:11 INFO - PROCESS | 10659 | |3;audio-fft;76;74;75;118;75;76;75;74;100;76 02:44:11 INFO - PROCESS | 10659 | |4;audio-oscillator;85;86;128;85;86;86;119;84;85;135 02:44:11 INFO - PROCESS | 10659 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;117;116;117 02:44:11 INFO - PROCESS | 10659 | |6;imaging-darkroom;147;146;146;146;148;146;146;147;148;148 02:44:11 INFO - PROCESS | 10659 | |7;imaging-desaturate;95;94;94;94;94;94;94;95;95;95 02:44:11 INFO - PROCESS | 10659 | |8;json-parse-financial;53;53;52;52;53;53;52;53;52;60 02:44:11 INFO - PROCESS | 10659 | |9;json-stringify-tinderbox;61;63;62;62;63;63;62;62;62;62 02:44:11 INFO - PROCESS | 10659 | |10;stanford-crypto-aes;78;78;79;77;79;79;81;80;90;80 02:44:11 INFO - PROCESS | 10659 | |11;stanford-crypto-ccm;129;131;130;117;119;124;134;125;150;123 02:44:11 INFO - PROCESS | 10659 | |12;stanford-crypto-pbkdf2;156;156;158;156;155;157;155;155;155;156 02:44:11 INFO - PROCESS | 10659 | |13;stanford-crypto-sha256-iterative;62;61;61;61;64;63;61;61;62;62 02:44:11 INFO - PROCESS | 10659 | __end_tp_report 02:44:11 INFO - PROCESS | 10659 | __start_cc_report 02:44:11 INFO - PROCESS | 10659 | _x_x_mozilla_cycle_collect,1652 02:44:11 INFO - PROCESS | 10659 | __end_cc_report 02:44:11 INFO - PROCESS | 10659 | __startTimestamp1466675051982__endTimestamp 02:44:11 INFO - PROCESS | 10659 | 02:44:11 INFO - PROCESS | 10659 | ------- Summary: start ------- 02:44:11 INFO - PROCESS | 10659 | Number of tests: 14 02:44:11 INFO - PROCESS | 10659 | 02:44:11 INFO - PROCESS | 10659 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.35 (3.0%) stddev-sans-first:1.05 02:44:11 INFO - PROCESS | 10659 | Values: 100.0 111.0 111.0 109.0 109.0 109.0 110.0 110.0 112.0 110.0 02:44:11 INFO - PROCESS | 10659 | 02:44:11 INFO - PROCESS | 10659 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:140.50 stddev:28.84 (20.5%) stddev-sans-first:30.40 02:44:11 INFO - PROCESS | 10659 | Values: 154.0 125.0 125.0 173.0 124.0 127.0 163.0 126.0 208.0 125.0 02:44:11 INFO - PROCESS | 10659 | 02:44:11 INFO - PROCESS | 10659 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 02:44:11 INFO - PROCESS | 10659 | Values: 160.0 160.0 161.0 161.0 160.0 161.0 161.0 162.0 163.0 161.0 02:44:11 INFO - PROCESS | 10659 | 02:44:11 INFO - PROCESS | 10659 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:14.92 (19.9%) stddev-sans-first:15.67 02:44:11 INFO - PROCESS | 10659 | Values: 76.0 74.0 75.0 118.0 75.0 76.0 75.0 74.0 100.0 76.0 02:44:11 INFO - PROCESS | 10659 | 02:44:11 INFO - PROCESS | 10659 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:85.00 stddev:20.67 (24.3%) stddev-sans-first:21.39 02:44:11 INFO - PROCESS | 10659 | Values: 85.0 86.0 128.0 85.0 86.0 86.0 119.0 84.0 85.0 135.0 02:44:11 INFO - PROCESS | 10659 | 02:44:11 INFO - PROCESS | 10659 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:44:11 INFO - PROCESS | 10659 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 02:44:11 INFO - PROCESS | 10659 | 02:44:11 INFO - PROCESS | 10659 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 02:44:11 INFO - PROCESS | 10659 | Values: 147.0 146.0 146.0 146.0 148.0 146.0 146.0 147.0 148.0 148.0 02:44:11 INFO - PROCESS | 10659 | 02:44:11 INFO - PROCESS | 10659 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:44:11 INFO - PROCESS | 10659 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 02:44:11 INFO - PROCESS | 10659 | 02:44:12 INFO - PROCESS | 10659 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:2.41 (4.5%) stddev-sans-first:2.55 02:44:12 INFO - PROCESS | 10659 | Values: 53.0 53.0 52.0 52.0 53.0 53.0 52.0 53.0 52.0 60.0 02:44:12 INFO - PROCESS | 10659 | 02:44:12 INFO - PROCESS | 10659 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 02:44:12 INFO - PROCESS | 10659 | Values: 61.0 63.0 62.0 62.0 63.0 63.0 62.0 62.0 62.0 62.0 02:44:12 INFO - PROCESS | 10659 | 02:44:12 INFO - PROCESS | 10659 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:3.67 (4.6%) stddev-sans-first:3.81 02:44:12 INFO - PROCESS | 10659 | Values: 78.0 78.0 79.0 77.0 79.0 79.0 81.0 80.0 90.0 80.0 02:44:12 INFO - PROCESS | 10659 | 02:44:12 INFO - PROCESS | 10659 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:129.50 stddev:9.34 (7.2%) stddev-sans-first:9.91 02:44:12 INFO - PROCESS | 10659 | Values: 129.0 131.0 130.0 117.0 119.0 124.0 134.0 125.0 150.0 123.0 02:44:12 INFO - PROCESS | 10659 | 02:44:12 INFO - PROCESS | 10659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 02:44:12 INFO - PROCESS | 10659 | Values: 156.0 156.0 158.0 156.0 155.0 157.0 155.0 155.0 155.0 156.0 02:44:12 INFO - PROCESS | 10659 | 02:44:12 INFO - PROCESS | 10659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.03 (1.7%) stddev-sans-first:1.09 02:44:12 INFO - PROCESS | 10659 | Values: 62.0 61.0 61.0 61.0 64.0 63.0 61.0 61.0 62.0 62.0 02:44:12 INFO - PROCESS | 10659 | -------- Summary: end -------- 02:44:12 INFO - PROCESS | 10659 | 02:44:12 INFO - TEST-INFO | 10659: exit 0 02:44:12 INFO - TEST-OK | kraken | took 61416ms 02:44:12 INFO - SUITE-END | took 1175s 02:44:13 INFO - Completed test suite (00:19:35) 02:44:13 INFO - javascript benchmark 02:44:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.831214283215, 3077.5229839374897, 3092.8453577321134, 3117.485614873546, 3130.827804470753, 5133.3326667533165, 5202.661826981243, 5206.453322401146, 5285.101532739434, 5308.203769434586, 5251.86870328242, 5256.947430525704, 5258.973705131469, 5354.170103633934, 5390.164524498709, 4735.076660051292, 4810.470848206694, 4818.807247710088, 4827.782749776251, 4985.302057711905, 4885.804567817283, 4896.534829191221, 4904.386951631046, 4955.182394904837, 4962.255661650745, 4604.378408914804, 4712.222483290253, 4761.809527618909, 4782.736949467778, 4785.0, 4770.689905156154, 4797.544233297831, 4849.587785038276, 4854.247591623269, 4893.559579637849, 4622.468416132154, 4787.186178349689, 4800.423949126092, 4831.0, 4862.197737373329, 5195.610329225286, 5283.63014588979, 5289.788408463657, 5361.035013697533, 5386.192071189353, 5700.116481945263, 5722.484976352107, 5746.827595172152, 5751.482366587027, 5751.539876809845, 5460.34475862899, 5609.831705048855, 5699.344575373843, 5723.828285151452, 5724.914126288068, 5309.707966061865, 5368.785248590091, 5388.380336261302, 5397.919031214535, 5405.756740946627, 5848.736806843703, 5850.3272123705465, 5850.795222167204, 5852.912206316909, 5862.413758624103, 5462.180672899018, 5469.343678758574, 5521.723913804293, 5624.437556244343, 5633.8309850704545, 5645.040343141676, 5680.715964201773, 5686.232358631614, 5690.829275121753, 5696.145578163226, 5606.579506536945, 5612.35457922336, 5613.803516876889, 5619.297587801525, 5619.634723742944, 5465.289512363367, 5584.888302233932, 5625.0, 5625.324961004706, 5645.576581756384, 4347.586979236968, 4348.34774783785, 4349.28236840924, 4349.325854492558, 4377.649788016951, 3884.9805750971063, 3896.7077469189926, 3903.6681882039775, 3934.6065393460426, 3957.0107473131716, 5260.9736951315, 5281.287026251483, 5319.494648008433, 5325.4142044375085, 5346.358436987586, 5669.121286200645, 5675.432456754292, 5692.743826527816, 5708.257926469532, 5735.7418916148035, 5391.379991301051, 5396.487333703292, 5399.406065332811, 5404.8108316208745, 5412.512873841373, 4787.497312782108, 4843.128236917319, 4898.90202195954, 4911.3369695090705, 4953.1332016896895, 5792.044312688444, 5875.383084776123, 5917.31950825652, 5919.704014799243, 5921.0, 5680.091185410314, 5681.4034526374135, 5687.459691329317, 5689.886202276014, 5692.857678558069, 5651.943480565142, 5786.826395208151, 5802.274715660543, 5847.561432892465, 5851.034579294369, 5528.806491772769, 5575.275214222125, 5612.102063669793, 5636.661800291996, 5642.492175704207, 5689.800856969986, 5713.257276554022, 5720.399358067343, 5727.713614319351, 5739.512141468022, 5377.623566350318, 5501.092319767194, 5535.723213839373, 5547.084731019498, 5551.195076713934, 5553.305836770403, 5578.3584887738425, 5583.0, 5588.105903055492, 5645.71771411436, 5433.864153396196, 5469.972650136724, 5482.369527504228, 5487.094629386106, 5487.231787549826, 5455.618106732491, 5482.945170548243, 5556.222128901876, 5629.352624448241, 5662.433756624305, 5453.127499600045, 5455.699936503531, 5461.945380546303, 5462.8907421850545, 5499.752511137089], "value": 5229.722774486113, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.0654818795913, 572.49620334106, 585.9882802343952, 598.0700011482146, 600.4025994135835, 26847.463050739, 35499.822500887494, 36615.81692091542, 36624.81687591565, 36663.0, 36741.0, 37030.62969370312, 37092.81453592728, 37134.8143259284, 37140.81429592848, 8500.404971651988, 8644.65421383144, 8647.0, 8648.135186481333, 8675.26260267878, 8436.704715334965, 8552.059273479912, 8554.315654747605, 8555.230029297392, 8559.144085591422, 8605.870911936294, 8625.870611940794, 8640.2223799858, 8644.481331120152, 8645.049044605088, 8558.657653693845, 8594.742157735278, 8599.398042137052, 8603.526806025666, 8604.440711353773, 8445.155484451567, 8524.10496897823, 8526.957365213197, 8533.317334613279, 8536.70121545743, 35628.82185589056, 35890.461643075374, 35918.64081359179, 35929.46105808415, 35951.820240898625, 3153.2905096353365, 3185.5540224368606, 3228.2736384313575, 3257.8533965971587, 3529.1710540104978, 28277.858610707022, 28567.714322856715, 28702.425951480855, 28832.0, 29900.700992990227, 4019.718619696622, 4020.43713880057, 4029.1538776856896, 4060.654844338235, 4061.5341806870756, 329528.0, 330210.0, 331024.0, 331202.3439882809, 332191.0, 45222.77388613036, 45271.77364113224, 45616.54383456123, 45652.0, 45655.0, 43749.34375984363, 46740.29889551659, 47662.523374766504, 47667.523324767004, 47727.0, 14249.572512824632, 14354.138751674933, 14363.353649085817, 14395.496157634641, 14406.567802965928, 10893.509792059376, 10944.835827462595, 10958.452077396258, 10959.616413425492, 10980.231383803057, 12324.137310388187, 13043.543475978295, 13126.474941002252, 13423.0, 13643.863561364458, 5052.368453943257, 5189.818356357509, 5197.610179236573, 5217.947820521822, 5245.580353571705, 834.2491757418372, 927.2211342472356, 937.4469063252714, 957.3729207369184, 1021.1116328793848, 27859.303517412227, 27991.860040699667, 28556.28609284743, 28827.423451530853, 28923.0, 951.6145960885852, 994.5027486256871, 1012.8784545854397, 1018.8930162332848, 1020.4489575629077, 14700.264986750833, 14853.554393368217, 14866.405343786344, 15202.771958420633, 15221.771673424908, 512416.0, 513186.0, 517809.0, 518743.0, 519923.0, 46409.30386044212, 46606.300905486445, 46633.53366466292, 46653.83365415824, 46741.5325846744, 1049.459528342904, 1126.7126882645036, 1137.1528211482498, 1161.1465572803982, 1192.7435601345753, 28181.71818281791, 29070.0, 29209.561856571745, 29475.0, 29688.703112968593, 41013.0, 41466.37800432936, 41539.1692166161, 41583.0, 41590.0, 376686.0, 378173.0, 378607.0, 381512.0, 389909.0, 27972.440551188454, 34035.65964340424, 34393.0, 35028.0, 37321.81339093287, 39622.02834787345, 39729.80135099306, 41157.588424115376, 42562.0, 43180.56819431765, 35326.293474130885, 36020.81989590035, 36035.0, 36193.0, 36481.27037459289, 34208.657913420546, 34342.48486272658, 34375.484367734, 34619.30761384808, 34658.306833862676, 34172.31655366928, 34225.315493689486, 34395.0, 34490.655093448746, 34961.65038349685, 30867.536986945663, 32092.67907320897, 32094.679053210104, 32118.518222227154, 32162.0, 24764.133255335975, 24842.0, 25064.62403063992, 25192.37019074538, 25237.74762252354], "value": 17695.862573696584, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.71702637889683, 354.485995306805, 362.16701586351394, 366.4905780964458, 373.2590807247613, 16901.57746056349, 17697.82302176978, 18755.53111172218, 18757.812421875777, 18782.154803033845, 16061.759073613905, 16657.750133747973, 16935.3225870965, 16951.0, 16959.236834342453, 5251.55361794248, 5540.307461567304, 5588.86027849305, 5590.468905453975, 5595.972020139893, 4050.392441133824, 4154.97922510387, 4242.172776308621, 5430.809921652743, 6195.628262304253, 6222.719977601018, 6252.062190671413, 6257.030160325134, 6257.812265632016, 6267.153934218868, 6094.8781024379705, 6132.938670613304, 6219.906701399483, 6232.688365581703, 6243.719032643542, 3611.476335931275, 5074.974625126888, 5426.2674538937135, 5510.779568817243, 5511.889762204733, 18495.907520462446, 18867.245310187576, 19119.904400478048, 21218.787812121835, 21245.362639120696, 2269.387265438339, 2370.7747763962398, 2374.8931298091456, 2390.796782273509, 2916.6354205724283, 13181.209127452288, 13509.527166549124, 13753.106048106842, 13851.445942162301, 14091.78862317066, 1920.7022911448748, 1924.2303078768605, 1939.2727727102338, 1998.9000549972443, 2060.3406909788873, 72451.0, 74788.25211747867, 75976.0, 76725.61637191834, 77751.0, 9480.155953214145, 9599.568019439143, 9630.133288004114, 9795.608175672893, 10024.448655323882, 13119.475220991244, 13188.406521706545, 13235.602931912059, 13285.335733213495, 13290.534831280858, 7708.2291770823595, 7715.4599178058115, 7816.7264145754625, 7856.685732570633, 7935.325497332791, 7709.997700299037, 7711.575863327571, 7734.57459839703, 7910.683572657029, 7925.524468531907, 5946.67293298864, 6029.879402411927, 6061.848453788691, 6064.241969753781, 6222.471089957314, 1693.102655592538, 1711.2213942656062, 1715.2350590453834, 1718.458685514084, 1747.2574155983657, 878.1481962496368, 878.4202426398547, 923.5151545438698, 929.0755698080453, 999.7700528878253, 18074.367397141035, 18660.066996650112, 18777.436676899713, 18796.718049229272, 18925.43223703291, 931.8509038553799, 934.039096065474, 956.364017928084, 970.3304719743354, 997.875265591801, 9989.450580218157, 10357.274990750575, 10458.477076146315, 10488.265821392582, 10529.84205236922, 423745.0, 437576.0, 461523.0, 464773.0, 466659.0, 77156.61421692856, 78420.64738057868, 80063.59968200239, 80416.0, 80456.5977170122, 896.2561074308309, 934.7102398256699, 948.037741692183, 956.3353469338742, 957.2150836314156, 16448.259828307517, 16851.24169412355, 17075.658486829947, 17096.145192740063, 17169.313227471263, 42258.57741422547, 42547.3617895738, 42870.78564607157, 43663.56336436722, 44744.77627611841, 55616.0, 55741.0, 56759.14861277167, 64563.35436645574, 64950.35049649632, 7948.721794737156, 8149.573824580793, 8245.093039765741, 8342.040665323566, 8903.554822258991, 7712.8457430852195, 9525.666406703205, 12296.13031796216, 13504.459821607026, 13527.0, 10846.403447810131, 11082.944585277022, 11157.330560166416, 11274.887251127384, 11632.185746997968, 11305.43472826339, 11372.829407558727, 11381.54473821071, 11556.248843825124, 11657.18399712012, 11464.94267528657, 11708.765824683629, 11829.585964491202, 11891.167618266638, 11960.0, 7143.357097861218, 7431.851362972819, 7496.212897645887, 7727.227277272228, 8443.704470343508, 10128.392296462236, 11172.329660220414, 11177.385243811668, 11812.704682382666, 11826.881731182579], "value": 8882.241786135333, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1119.0264469911178, 1159.2263836330417, 1184.828199911013, 1231.926084434934, 1511.8488151184877, 7952.085510166333, 8248.505089694623, 8275.420720549564, 8523.360747943914, 8532.8720069199, 8181.100078991306, 8350.83298334033, 8360.749177524684, 8362.832743345145, 8381.455205411645, 1982.692682634194, 2164.2100633268824, 2251.0995601759264, 2281.7604151564055, 2310.9653355199684, 2278.5784629843533, 2286.2683941138844, 2290.438842483594, 2290.7365652949957, 2292.4727312718087, 2281.7147856517936, 2295.1393227539675, 2313.3175713164655, 2318.385627808632, 2319.141917490531, 1939.3987863762209, 2183.410479170631, 2256.5261295128043, 2259.175400978639, 2259.9661005084936, 2220.877851718171, 2257.7403598586206, 2277.555876604063, 2278.2140161644206, 2280.486890449652, 8611.095834937367, 8785.34109941757, 8789.340799440068, 8791.868121978176, 8793.384463087586, 5075.543201111917, 5222.738863056832, 5226.372835259755, 5228.2680424740565, 5228.895422091575, 3079.507278835398, 3225.8064516129107, 3287.5068739689, 3302.2734998300575, 3329.716974057208, 1055.6358056470506, 1064.9414282214475, 1075.9892401075967, 1077.95688172473, 1082.9133669306436, 12153.210041347284, 12180.878191218064, 12191.146619736623, 12195.634130975996, 12197.20718153326, 4426.136903303889, 4527.139843429738, 4575.565321294472, 4644.442666879996, 4646.7444290564345, 10210.591576336863, 10237.846432303522, 10241.48792560369, 10243.282970192164, 10245.0, 5113.130767769489, 5139.306193663882, 5141.280220769096, 5144.7942082316285, 5178.792848286026, 4119.196756632428, 4536.274196128604, 4667.883302917387, 4693.624510039189, 4797.136515427256, 3664.340418724655, 3744.8314825832904, 3761.360568703327, 3808.1050953026015, 3834.6357096075826, 1186.9643910682694, 1187.6080893305189, 1190.791611468007, 1207.076586411396, 1213.7754515414676, 913.4291068082448, 922.7785331520521, 929.6188562689265, 930.6649606141783, 948.2366694810744, 5652.519535839418, 5680.699316776712, 5836.517644241815, 6009.849753756103, 6021.488173505213, 391.6925213707283, 408.9120839019625, 411.6151398442466, 420.2288800051939, 429.1224446007921, 3912.7065470089856, 4030.9798451008146, 4031.637152656275, 4036.6367026967714, 4046.7976601170412, 10704.09015233714, 10751.731206719738, 10994.560217591206, 11057.281276716987, 11089.27919685218, 10891.727706807393, 10948.507317170746, 10986.066184374258, 10991.0, 10994.450277486094, 8022.598870056474, 8073.990751156223, 8080.676772929134, 8098.109207987117, 8246.299064579578, 5535.197396377423, 5549.750261238173, 5682.687452190169, 5767.625104368202, 5793.739281732416, 10004.899951000689, 10079.496025198858, 10114.140298074746, 10177.084062434416, 10185.388876667128, 10004.699859003951, 10167.0, 10439.164866810788, 10446.373217606968, 10521.579136834747, 7329.083864516935, 7545.962270188614, 7581.393488520795, 7582.090149182133, 7744.225577442211, 8518.063013068682, 8552.743417697478, 8596.613152408032, 8604.139586041345, 8606.870896936425, 7065.682044307916, 7284.053073100463, 7293.52592081513, 7360.263973602597, 7425.0, 7562.205968373241, 7625.428092892944, 7680.270374314431, 7770.844583108419, 7794.610269486389, 6839.418649414855, 6899.0, 6913.239543650295, 6913.654317284217, 6925.549839260432, 4937.975310123426, 4955.331030310862, 4966.155753521982, 5150.948490515047, 5197.7141257231215, 5014.247862820606, 5024.773885175103, 5134.845954621367, 5177.585793136464, 5202.167653175474], "value": 4407.937856182972, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.66589753578467, 312.92333378322314, 314.5109354953048, 315.846814295067, 320.94383482890487, 5312.973435132823, 5348.438413966536, 5371.5165635092835, 5381.0, 5385.545902606299, 5000.7749651265685, 5061.6709913855575, 5236.764345604447, 5300.337457817773, 5302.708351040691, 4142.896427589304, 4171.374293855931, 4186.937195942063, 4196.286631272691, 4196.769177695218, 4152.667786577082, 4178.579283043765, 4187.7277976931555, 4194.433751443562, 4201.6008479194425, 3890.8054597270166, 3958.0896393829435, 4064.9390259146135, 4088.0393107619684, 4161.7086803923585, 4062.410950412174, 4071.307877660805, 4094.3858421236755, 4152.231837110129, 4157.210130075276, 3596.7841929484052, 3627.3470775260444, 3638.43604241343, 3647.4893514907667, 3671.2657468506404, 5103.668261562986, 5130.589552835801, 5188.45521220274, 5196.64816193553, 5206.479352064801, 4678.532146785328, 4684.601808846252, 4714.83498077569, 4729.668923175379, 4739.3601863748645, 5531.059719847635, 5544.695041772701, 5561.944380556183, 5566.443355664442, 5569.081101618228, 3901.6200117928042, 3959.6436320730986, 3998.640122388999, 4000.879973600797, 4016.357382818735, 5666.858328541819, 5682.943170568283, 5691.772329106872, 5779.508741756956, 5783.652980821164, 4071.694622903294, 4080.18396320737, 4085.428040074392, 4103.2409004334295, 4120.979395103005, 4020.1557672888434, 4139.379093135994, 4143.647789937889, 4162.854300099482, 4173.916521669549, 4685.273782563708, 4699.342092107107, 4732.5977291929885, 4739.810407583658, 4742.264948932921, 5576.86057848557, 5578.86052848682, 5588.972055139699, 5648.915266271009, 5657.010023245915, 1379.7861331493634, 1418.4609848257596, 1439.3235179465635, 1455.316001479303, 1455.89080818939, 876.6931573949067, 886.7339798060556, 892.9419587726777, 1001.3541265883464, 1002.9699109026741, 5261.210818377198, 5269.55208807248, 5290.709011004432, 5301.416844147141, 5305.8938821223355, 5505.339359276913, 5659.830205093854, 5705.429457054262, 5720.513756330759, 5720.971395143081, 5308.92036619451, 5314.28257185275, 5327.840164795062, 5344.835341686623, 5364.544013758874, 2974.2267010576975, 2997.610310659644, 3009.5485677148604, 3012.2770535071427, 3013.6986301370125, 5565.41563135873, 5787.826365209051, 5814.912776308359, 5844.532437404998, 5847.970760146172, 5650.576206784425, 5702.8289151325525, 5703.174984005162, 5722.713864306768, 5749.626274292241, 5815.854603634858, 5820.185174075633, 5832.104566015977, 5850.648961062265, 5858.707064646751, 5382.946170538245, 5695.266272189289, 5696.401877802771, 5704.60067795267, 5743.0811070228565, 5644.0, 5668.829935101789, 5676.20533125371, 5686.175504551734, 5706.430731548691, 5685.715714214355, 5897.351291357862, 5898.292204935264, 5956.940430595639, 5961.91057134152, 4037.6783349573525, 4063.7764922929523, 4074.103697186614, 4081.510218773766, 4087.3051581230666, 5747.367789543064, 5748.109043098327, 5751.022326204472, 5753.827385178452, 5795.392073566827, 5472.972635136799, 5596.076647353141, 5607.8037268697035, 5610.579206559442, 5620.494155526022, 5539.750711217925, 5561.0, 5561.916571251515, 5564.33228012641, 5626.690532020614, 5208.583313335, 5255.3168088148295, 5432.891342173055, 5489.451054894478, 5493.450654934474, 5632.436756324335, 5632.5775566831835, 5669.489745922887, 5675.744591493475, 5680.772769089355, 5445.700486473282, 5538.584606154635, 5545.168224766156, 5554.91667624994, 5560.499555040065], "value": 4230.947690618887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.7010322099242, 645.9095726598274, 683.617174382346, 698.7519430602136, 724.2431658916433, 13876.722465550683, 14321.71356572868, 14345.569632911016, 14399.92800036001, 14444.133351998875, 12099.09256805741, 12701.872981270184, 12713.809292860591, 12729.554465593683, 12730.363481825918, 652.4910569755574, 762.6987340000696, 776.809681628002, 796.6176235406979, 798.4251339035885, 789.4237206839011, 792.5086446403209, 793.9007624046994, 794.4161041634394, 797.5015615240475, 828.70580943765, 829.3821103278066, 830.0122853803954, 830.4228561150003, 831.0276975938167, 526.8261473713684, 786.8701664225367, 814.9266566009028, 816.1512027491402, 822.5106061893164, 594.6313285762811, 594.6967046806117, 595.4908553187006, 595.7200115945542, 600.471585005197, 13550.728985420237, 13591.116577422436, 13598.116122452107, 13655.317234138352, 13720.245386503739, 13749.0, 13890.0, 14017.158970461805, 14231.430742770277, 14439.0, 12876.420561074774, 12887.226766394046, 13071.542496012595, 13171.47314107444, 13710.52013179544, 4224.704270701052, 4243.787810609457, 4306.504751953534, 4307.91384172318, 4318.632916202127, 76895.0, 76923.0, 77342.0, 79094.604526977, 79686.0, 10713.410762407986, 10754.838677419844, 10784.260056434458, 10974.396408197466, 11087.113030957504, 19164.71252931207, 19170.04149792505, 19178.328758493666, 19217.0, 19218.231270749013, 8203.95898020518, 8253.0, 8332.375071869634, 8402.915970840335, 8582.699605513777, 4410.051838854662, 4508.864734057984, 4531.524189960072, 4553.142446603068, 4671.416072990876, 3514.525539052195, 3640.8543658253375, 3652.8538858445363, 3658.268346330691, 3658.304922064799, 557.2588457351712, 566.068653203506, 608.3733754233147, 625.0624063904144, 626.2078470734433, 554.7448173839998, 644.8033349828347, 656.5076192855358, 657.947364210862, 662.7084083003463, 8983.955080224689, 9031.63873445068, 9445.66940157105, 9495.477748723748, 9683.709488715349, 603.7856560920898, 609.2262826210688, 628.9465395441347, 640.6540468147149, 656.8062421585644, 4296.9570304297185, 4373.9125217495475, 4464.397306363664, 4510.864674059783, 4631.637864688965, 64006.0, 65311.67344163249, 128680.0, 130241.0, 133146.0, 113407.0, 114927.0, 115470.0, 116147.0, 117168.0, 91790.0, 92067.0, 92525.39768077781, 95587.52206238924, 96460.51769741246, 8564.957175214084, 8705.347098967477, 8712.651493940171, 8730.519821409884, 8834.646614135363, 54939.175912362145, 55184.44815551793, 55775.163372550254, 56527.71736141457, 57224.42775572191, 72160.63919680368, 85064.57467712622, 86043.13956860351, 86376.0, 86447.0, 11627.244229125079, 12153.661749992683, 12370.62888113358, 12465.189762665397, 13266.734665306447, 12893.806592900926, 13765.518206862711, 13776.878370699646, 13889.374978125807, 14306.284685765462, 9219.386607343555, 11595.652130436101, 12077.818832717341, 12198.57304994321, 12725.172863763826, 13359.799603006157, 13369.331533423096, 13781.793273101111, 13823.377947992565, 14184.432622694976, 13791.586252412444, 13934.0, 14004.36980335867, 14102.435902563782, 14435.78346324827, 10737.463126843782, 10930.781384372427, 11065.944670276596, 11172.106231501622, 11249.30832157693, 10246.53890574911, 10976.725581860517, 11082.501287442246, 11554.27692765563, 11773.117016223647], "value": 7330.821154423537, "unit": "score"}], "name": "dromaeo_css", "value": 6946.884644879198, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 111.0, 109.0, 109.0, 109.0, 110.0, 110.0, 112.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 125.0, 173.0, 124.0, 127.0, 163.0, 126.0, 208.0, 125.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 163.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 118.0, 75.0, 76.0, 75.0, 74.0, 100.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 128.0, 85.0, 86.0, 86.0, 119.0, 84.0, 85.0, 135.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0, 148.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 52.0, 53.0, 53.0, 52.0, 53.0, 52.0, 60.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 77.0, 79.0, 79.0, 81.0, 80.0, 90.0, 80.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 130.0, 117.0, 119.0, 124.0, 134.0, 125.0, 150.0, 123.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 158.0, 156.0, 155.0, 157.0, 155.0, 155.0, 155.0, 156.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 64.0, 63.0, 61.0, 61.0, 62.0, 62.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1494.1999999999998, "alertThreshold": 2.0}]} 02:44:13 INFO - Return code: 0 02:44:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:44:13 INFO - # TBPL SUCCESS # 02:44:13 INFO - Running post-action listener: _resource_record_post_action 02:44:13 INFO - ##### 02:44:13 INFO - ##### Finished run-tests step (success) 02:44:13 INFO - ##### 02:44:13 INFO - Running post-run listener: _resource_record_post_run 02:44:13 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 309784576; Read time: 0; Write time: 252412 02:44:13 INFO - TinderboxPrint: CPU usage
13.2% 02:44:13 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:44:13 INFO - TinderboxPrint: I/O write bytes / time
309,784,576 / 252,412 02:44:13 INFO - TinderboxPrint: CPU idle
8,273.0 (86.8%) 02:44:13 INFO - TinderboxPrint: CPU user
1,207.9 (12.7%) 02:44:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:44:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20541440; Read time: 0; Write time: 11796 02:44:13 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289243136; Read time: 0; Write time: 240616 02:44:13 INFO - Running post-run listener: _upload_blobber_files 02:44:13 INFO - Blob upload gear active. 02:44:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:44:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:44:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:44:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:44:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:44:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:44:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:15 INFO - (blobuploader) - INFO - Done attempting. 02:44:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:44:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:24 INFO - (blobuploader) - INFO - Done attempting. 02:44:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:44:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:44:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:25 INFO - (blobuploader) - INFO - Done attempting. 02:44:25 INFO - (blobuploader) - INFO - Iteration through files over. 02:44:25 INFO - Return code: 0 02:44:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:44:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:44:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df6f02f1a18b487986cad43679fdf77083ce397593b73da796754850ea7e6080a8e49fdf5c5ca3d56d58595252d0d5f4b756a855b55c7ab92b2c7e38421dec85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/35340ef6c3f6ac00c0e0da0812577ce77fb37e5a4209e8acfa5ad56edc13f2ea83000fc7700917342c5a31a2cb5a567dc690a5df492f10a142b0c2bc63a6753e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0297e014069470103f4c6333fadf93394c7ec7be277dee1e63ea714664875ac35bfc995c19cd41672abc9c47b12171416b625403a73041298c5ec487614b808d"} 02:44:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:44:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:44:25 INFO - Contents: 02:44:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df6f02f1a18b487986cad43679fdf77083ce397593b73da796754850ea7e6080a8e49fdf5c5ca3d56d58595252d0d5f4b756a855b55c7ab92b2c7e38421dec85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/35340ef6c3f6ac00c0e0da0812577ce77fb37e5a4209e8acfa5ad56edc13f2ea83000fc7700917342c5a31a2cb5a567dc690a5df492f10a142b0c2bc63a6753e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0297e014069470103f4c6333fadf93394c7ec7be277dee1e63ea714664875ac35bfc995c19cd41672abc9c47b12171416b625403a73041298c5ec487614b808d"} 02:44:25 INFO - Running post-run listener: copy_logs_to_upload_dir 02:44:25 INFO - Copying logs to upload dir... 02:44:25 INFO - mkdir: /builds/slave/test/build/upload/logs 02:44:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.438000 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-23 02:44:23.710830) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 02:44:23.714693) ========= 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=cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df6f02f1a18b487986cad43679fdf77083ce397593b73da796754850ea7e6080a8e49fdf5c5ca3d56d58595252d0d5f4b756a855b55c7ab92b2c7e38421dec85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/35340ef6c3f6ac00c0e0da0812577ce77fb37e5a4209e8acfa5ad56edc13f2ea83000fc7700917342c5a31a2cb5a567dc690a5df492f10a142b0c2bc63a6753e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0297e014069470103f4c6333fadf93394c7ec7be277dee1e63ea714664875ac35bfc995c19cd41672abc9c47b12171416b625403a73041298c5ec487614b808d"} build_url:https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df6f02f1a18b487986cad43679fdf77083ce397593b73da796754850ea7e6080a8e49fdf5c5ca3d56d58595252d0d5f4b756a855b55c7ab92b2c7e38421dec85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/35340ef6c3f6ac00c0e0da0812577ce77fb37e5a4209e8acfa5ad56edc13f2ea83000fc7700917342c5a31a2cb5a567dc690a5df492f10a142b0c2bc63a6753e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0297e014069470103f4c6333fadf93394c7ec7be277dee1e63ea714664875ac35bfc995c19cd41672abc9c47b12171416b625403a73041298c5ec487614b808d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 02:44:23.743502) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:44:23.743840) ========= 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=cbe409c6de289db6ac707de3000001d4-1466673801.617648-1072496673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:44:23.828659) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 02:44:23.829055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 02:44:23.829392) ========= ========= Total master_lag: 0.17 =========