builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1470048017.96 results: success (0) buildid: 20160731234823 builduid: ac593188bfc9435eb9125393ed1fd078 revision: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:17.958655) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:17.959108) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:17.959440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:17.976468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:17.976751) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 03:40:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.2M=0s 2016-08-01 03:40:18 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147494 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:18.138519) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:18.138856) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016507 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:18.188405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:18.188890) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff --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=74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 03:40:18,312 truncating revision to first 12 chars 2016-08-01 03:40:18,312 Setting DEBUG logging. 2016-08-01 03:40:18,312 attempt 1/10 2016-08-01 03:40:18,312 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fcdf4bb70356?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 03:40:18,634 unpacking tar archive at: mozilla-aurora-fcdf4bb70356/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660346 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:18.863538) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:18.864029) ========= script_repo_revision: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:18.864503) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:18.864968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:18.878078) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-01 03:40:18.878391) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:40:19 INFO - MultiFileLogger online at 20160801 03:40:19 in /builds/slave/test 03:40:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:40:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:40:19 INFO - {'append_to_log': False, 03:40:19 INFO - 'base_work_dir': '/builds/slave/test', 03:40:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:40:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:40:19 INFO - 'branch': 'Mozilla-Aurora', 03:40:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:40:19 INFO - 'config_files': ('talos/linux_config.py',), 03:40:19 INFO - 'default_actions': ('clobber', 03:40:19 INFO - 'read-buildbot-config', 03:40:19 INFO - 'download-and-extract', 03:40:19 INFO - 'populate-webroot', 03:40:19 INFO - 'create-virtualenv', 03:40:19 INFO - 'install', 03:40:19 INFO - 'run-tests'), 03:40:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:40:19 INFO - 'download_minidump_stackwalk': True, 03:40:19 INFO - 'download_symbols': 'ondemand', 03:40:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:40:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:40:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:40:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:40:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:40:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:40:19 INFO - 'installer_path': 'installer.exe', 03:40:19 INFO - 'log_level': 'info', 03:40:19 INFO - 'log_name': 'talos', 03:40:19 INFO - 'log_to_console': True, 03:40:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:40:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:40:19 INFO - 'opt_config_files': (), 03:40:19 INFO - 'pip_index': False, 03:40:19 INFO - 'sps_profile': False, 03:40:19 INFO - 'sps_profile_interval': 0, 03:40:19 INFO - 'suite': 'dromaeojs', 03:40:19 INFO - 'system_bits': '32', 03:40:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:40:19 INFO - 'title': 'talos-linux64-ix-042', 03:40:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:40:19 INFO - 'use_talos_json': True, 03:40:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:40:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:40:19 INFO - 'work_dir': 'build'} 03:40:19 INFO - ##### 03:40:19 INFO - ##### Running clobber step. 03:40:19 INFO - ##### 03:40:19 INFO - Running pre-action listener: _resource_record_pre_action 03:40:19 INFO - Running main action method: clobber 03:40:19 INFO - rmtree: /builds/slave/test/build 03:40:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:40:19 INFO - Running post-action listener: _resource_record_post_action 03:40:19 INFO - ##### 03:40:19 INFO - ##### Finished clobber step (success) 03:40:19 INFO - ##### 03:40:19 INFO - ##### 03:40:19 INFO - ##### Running read-buildbot-config step. 03:40:19 INFO - ##### 03:40:19 INFO - Running pre-action listener: _resource_record_pre_action 03:40:19 INFO - Running main action method: read_buildbot_config 03:40:19 INFO - Using buildbot properties: 03:40:19 INFO - { 03:40:19 INFO - "project": "", 03:40:19 INFO - "product": "firefox", 03:40:19 INFO - "script_repo_revision": "production", 03:40:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:40:19 INFO - "repository": "", 03:40:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:40:19 INFO - "buildid": "20160731234823", 03:40:19 INFO - "pgo_build": "True", 03:40:19 INFO - "basedir": "/builds/slave/test", 03:40:19 INFO - "buildnumber": 403, 03:40:19 INFO - "slavename": "talos-linux64-ix-042", 03:40:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:40:19 INFO - "platform": "ubuntu64_hw", 03:40:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:40:19 INFO - "branch": "mozilla-aurora", 03:40:19 INFO - "repo_path": "releases/mozilla-aurora", 03:40:19 INFO - "revision": "fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff", 03:40:19 INFO - "stage_platform": "linux64-pgo", 03:40:19 INFO - "builduid": "ac593188bfc9435eb9125393ed1fd078", 03:40:19 INFO - "slavebuilddir": "test" 03:40:19 INFO - } 03:40:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:40:19 INFO - Running post-action listener: _resource_record_post_action 03:40:19 INFO - ##### 03:40:19 INFO - ##### Finished read-buildbot-config step (success) 03:40:19 INFO - ##### 03:40:19 INFO - ##### 03:40:19 INFO - ##### Running download-and-extract step. 03:40:19 INFO - ##### 03:40:19 INFO - Running pre-action listener: _resource_record_pre_action 03:40:19 INFO - Running main action method: download_and_extract 03:40:19 INFO - mkdir: /builds/slave/test/build/tests 03:40:19 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')]} 03:40:19 INFO - https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:40:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:40:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:40:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:40:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:40:22 INFO - Downloaded 1361 bytes. 03:40:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:40:22 INFO - Using the following test package requirements: 03:40:22 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:22 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:40:22 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:40:22 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:22 INFO - u'jsshell-linux-x86_64.zip'], 03:40:22 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:40:22 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:22 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:40:22 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:40:22 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:40:22 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:40:22 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:22 INFO - https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:40:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:23 INFO - Downloaded 21967710 bytes. 03:40:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:40:24 INFO - Return code: 0 03:40:24 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:40: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')]} 03:40:24 INFO - https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:40:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:25 INFO - Downloaded 21967710 bytes. 03:40:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:40:27 INFO - Return code: 0 03:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:27 INFO - https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:40:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:40:27 INFO - Downloaded 10833369 bytes. 03:40:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:40:28 INFO - Return code: 0 03:40: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')]} 03:40:28 INFO - https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:40:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:40:29 INFO - Downloaded 61985118 bytes. 03:40:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:29 INFO - mkdir: /builds/slave/test/properties 03:40:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:29 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:29 INFO - Contents: 03:40:29 INFO - build_url:https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:30 INFO - Running post-action listener: _resource_record_post_action 03:40:30 INFO - Running post-action listener: set_extra_try_arguments 03:40:30 INFO - ##### 03:40:30 INFO - ##### Finished download-and-extract step (success) 03:40:30 INFO - ##### 03:40:30 INFO - ##### 03:40:30 INFO - ##### Running populate-webroot step. 03:40:30 INFO - ##### 03:40:30 INFO - Running pre-action listener: _resource_record_pre_action 03:40:30 INFO - Running main action method: populate_webroot 03:40:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:30 INFO - '--tppagecycles', 03:40:30 INFO - '7'], 03:40:30 INFO - 'tests': ['tsvgm']}}, 03:40:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:40:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:40:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:40:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:40:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:30 INFO - 'talos_options': ['--disable-e10s'], 03:40:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:30 INFO - 'talos_options': ['--disable-e10s'], 03:40:30 INFO - 'tests': ['damp', 'tps']}, 03:40:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:30 INFO - 'tests': ['damp', 'tps']}, 03:40:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:40:30 INFO - 'tests': ['dromaeo_dom']}, 03:40:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:40:30 INFO - 'tests': ['a11yr', 03:40:30 INFO - 'ts_paint', 03:40:30 INFO - 'tpaint', 03:40:30 INFO - 'sessionrestore', 03:40:30 INFO - 'sessionrestore_no_auto_restore', 03:40:30 INFO - 'tabpaint']}, 03:40:30 INFO - 'other-e10s': {'tests': ['a11yr', 03:40:30 INFO - 'ts_paint', 03:40:30 INFO - 'tpaint', 03:40:30 INFO - 'sessionrestore', 03:40:30 INFO - 'sessionrestore_no_auto_restore', 03:40:30 INFO - 'tabpaint']}, 03:40:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:40:30 INFO - 'ts_paint', 03:40:30 INFO - 'tpaint', 03:40:30 INFO - 'sessionrestore', 03:40:30 INFO - 'sessionrestore_no_auto_restore', 03:40:30 INFO - 'tabpaint']}, 03:40:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:40:30 INFO - 'ts_paint', 03:40:30 INFO - 'tpaint', 03:40:30 INFO - 'sessionrestore', 03:40:30 INFO - 'sessionrestore_no_auto_restore', 03:40:30 INFO - 'tabpaint']}, 03:40:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:40:30 INFO - 'tests': ['a11yr', 03:40:30 INFO - 'ts_paint', 03:40:30 INFO - 'tpaint', 03:40:30 INFO - 'sessionrestore', 03:40:30 INFO - 'sessionrestore_no_auto_restore', 03:40:30 INFO - 'tabpaint']}, 03:40:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:40:30 INFO - 'tests': ['a11yr', 03:40:30 INFO - 'ts_paint', 03:40:30 INFO - 'tpaint', 03:40:30 INFO - 'sessionrestore', 03:40:30 INFO - 'sessionrestore_no_auto_restore', 03:40:30 INFO - 'tabpaint']}, 03:40:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:40:30 INFO - 'tests': ['tsvgx', 03:40:30 INFO - 'tsvgr_opacity', 03:40:30 INFO - 'tart', 03:40:30 INFO - 'tscrollx', 03:40:30 INFO - 'cart']}, 03:40:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:40:30 INFO - 'tsvgr_opacity', 03:40:30 INFO - 'tart', 03:40:30 INFO - 'tscrollx', 03:40:30 INFO - 'cart']}, 03:40:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:30 INFO - 'talos_options': ['--disable-e10s'], 03:40:30 INFO - 'tests': ['tp5o']}, 03:40:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:30 INFO - 'tests': ['tp5o']}, 03:40:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:30 INFO - 'talos_options': ['--disable-e10s', 03:40:30 INFO - '--xperf_path', 03:40:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:30 INFO - 'tests': ['tp5n']}, 03:40:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:30 INFO - 'talos_options': ['--xperf_path', 03:40:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:30 INFO - 'tests': ['tp5n']}}, 03:40:30 INFO - 'talos.zip': {'path': '', 03:40:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:30 INFO - Running post-action listener: _resource_record_post_action 03:40:30 INFO - ##### 03:40:30 INFO - ##### Finished populate-webroot step (success) 03:40:30 INFO - ##### 03:40:30 INFO - ##### 03:40:30 INFO - ##### Running create-virtualenv step. 03:40:30 INFO - ##### 03:40:30 INFO - Running pre-action listener: _resource_record_pre_action 03:40:30 INFO - Running main action method: create_virtualenv 03:40:30 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40:30 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 03:40:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:30 INFO - Using real prefix '/usr' 03:40:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:30 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:32 INFO - Installing pip.................done. 03:40:32 INFO - Return code: 0 03:40:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:32 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 0x7fdabdf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c1c0>, '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 0x244d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', '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 03:40:32 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 03:40:32 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 03:40:32 INFO - Using env: {'DISPLAY': ':0', 03:40:32 INFO - 'HOME': '/home/cltbld', 03:40:32 INFO - 'LANG': 'en_US.UTF-8', 03:40:32 INFO - 'LANGUAGE': 'en_US:en', 03:40:32 INFO - 'LOGNAME': 'cltbld', 03:40:32 INFO - 'MAIL': '/var/mail/cltbld', 03:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:32 INFO - 'MOZ_NO_REMOTE': '1', 03:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:32 INFO - 'NO_EM_RESTART': '1', 03:40:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:32 INFO - 'PWD': '/builds/slave/test', 03:40:32 INFO - 'SHELL': '/bin/bash', 03:40:32 INFO - 'SHLVL': '1', 03:40:32 INFO - 'TERM': 'linux', 03:40:32 INFO - 'TMOUT': '86400', 03:40:32 INFO - 'USER': 'cltbld', 03:40:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', 03:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:32 INFO - '_': '/tools/buildbot/bin/python'} 03:40:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:32 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 03:40:32 INFO - Cleaning up... 03:40:32 INFO - Return code: 0 03:40:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:32 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 0x7fdabdf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c1c0>, '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 0x244d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', '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 03:40:32 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 03:40:32 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 03:40:32 INFO - Using env: {'DISPLAY': ':0', 03:40:32 INFO - 'HOME': '/home/cltbld', 03:40:32 INFO - 'LANG': 'en_US.UTF-8', 03:40:32 INFO - 'LANGUAGE': 'en_US:en', 03:40:32 INFO - 'LOGNAME': 'cltbld', 03:40:32 INFO - 'MAIL': '/var/mail/cltbld', 03:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:32 INFO - 'MOZ_NO_REMOTE': '1', 03:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:32 INFO - 'NO_EM_RESTART': '1', 03:40:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:32 INFO - 'PWD': '/builds/slave/test', 03:40:32 INFO - 'SHELL': '/bin/bash', 03:40:32 INFO - 'SHLVL': '1', 03:40:32 INFO - 'TERM': 'linux', 03:40:32 INFO - 'TMOUT': '86400', 03:40:32 INFO - 'USER': 'cltbld', 03:40:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', 03:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:32 INFO - '_': '/tools/buildbot/bin/python'} 03:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:33 INFO - Downloading/unpacking psutil>=3.1.1 03:40:33 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 03:40:33 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 03:40:33 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 03:40:33 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 03:40:33 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 03:40:33 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 03:40:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:35 INFO - Installing collected packages: psutil 03:40:35 INFO - Running setup.py install for psutil 03:40:35 INFO - building 'psutil._psutil_linux' extension 03:40:35 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 03:40:35 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 03:40:35 INFO - building 'psutil._psutil_posix' extension 03:40:35 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 03:40:35 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 03:40:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:35 INFO - Successfully installed psutil 03:40:35 INFO - Cleaning up... 03:40:35 INFO - Return code: 0 03:40:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:40:35 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')]} 03:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:35 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')]} 03:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:35 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 0x7fdabdf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c1c0>, '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 0x244d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', '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 03:40:35 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 03:40:35 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 03:40:35 INFO - Using env: {'DISPLAY': ':0', 03:40:35 INFO - 'HOME': '/home/cltbld', 03:40:35 INFO - 'LANG': 'en_US.UTF-8', 03:40:35 INFO - 'LANGUAGE': 'en_US:en', 03:40:35 INFO - 'LOGNAME': 'cltbld', 03:40:35 INFO - 'MAIL': '/var/mail/cltbld', 03:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:35 INFO - 'MOZ_NO_REMOTE': '1', 03:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:35 INFO - 'NO_EM_RESTART': '1', 03:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:35 INFO - 'PWD': '/builds/slave/test', 03:40:35 INFO - 'SHELL': '/bin/bash', 03:40:35 INFO - 'SHLVL': '1', 03:40:35 INFO - 'TERM': 'linux', 03:40:35 INFO - 'TMOUT': '86400', 03:40:35 INFO - 'USER': 'cltbld', 03:40:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', 03:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:35 INFO - '_': '/tools/buildbot/bin/python'} 03:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:40:35 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 03:40:35 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 03:40:35 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 03:40:35 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 03:40:35 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 03:40:35 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 03:40:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:40:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:40:37 INFO - Installing collected packages: mozsystemmonitor 03:40:37 INFO - Running setup.py install for mozsystemmonitor 03:40:38 INFO - Successfully installed mozsystemmonitor 03:40:38 INFO - Cleaning up... 03:40:38 INFO - Return code: 0 03:40:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdabdf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c1c0>, '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 0x244d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', '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 03:40:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:40:38 INFO - Using env: {'DISPLAY': ':0', 03:40:38 INFO - 'HOME': '/home/cltbld', 03:40:38 INFO - 'LANG': 'en_US.UTF-8', 03:40:38 INFO - 'LANGUAGE': 'en_US:en', 03:40:38 INFO - 'LOGNAME': 'cltbld', 03:40:38 INFO - 'MAIL': '/var/mail/cltbld', 03:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:38 INFO - 'MOZ_NO_REMOTE': '1', 03:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:38 INFO - 'NO_EM_RESTART': '1', 03:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:38 INFO - 'PWD': '/builds/slave/test', 03:40:38 INFO - 'SHELL': '/bin/bash', 03:40:38 INFO - 'SHLVL': '1', 03:40:38 INFO - 'TERM': 'linux', 03:40:38 INFO - 'TMOUT': '86400', 03:40:38 INFO - 'USER': 'cltbld', 03:40:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', 03:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:38 INFO - '_': '/tools/buildbot/bin/python'} 03:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:38 INFO - Downloading/unpacking jsonschema==2.5.1 03:40:38 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 03:40:38 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 03:40:38 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 03:40:38 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 03:40:38 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 03:40:38 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 03:40:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:40:40 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 03:40:40 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 03:40:40 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 03:40:40 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 03:40:40 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 03:40:40 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 03:40:40 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:40 INFO - warning: no files found matching '*.txt' 03:40:40 INFO - no previously-included directories found matching 'build' 03:40:40 INFO - no previously-included directories found matching 'dist' 03:40:40 INFO - no previously-included directories found matching '.git*' 03:40:40 INFO - Installing collected packages: jsonschema, functools32 03:40:40 INFO - Running setup.py install for functools32 03:40:40 INFO - warning: no files found matching '*.txt' 03:40:40 INFO - no previously-included directories found matching 'build' 03:40:40 INFO - no previously-included directories found matching 'dist' 03:40:40 INFO - no previously-included directories found matching '.git*' 03:40:40 INFO - Successfully installed jsonschema functools32 03:40:40 INFO - Cleaning up... 03:40:40 INFO - Return code: 0 03:40:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:40 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 0x7fdabdf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c1c0>, '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 0x244d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', '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 03:40:40 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 03:40:40 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 03:40:40 INFO - Using env: {'DISPLAY': ':0', 03:40:40 INFO - 'HOME': '/home/cltbld', 03:40:40 INFO - 'LANG': 'en_US.UTF-8', 03:40:40 INFO - 'LANGUAGE': 'en_US:en', 03:40:40 INFO - 'LOGNAME': 'cltbld', 03:40:40 INFO - 'MAIL': '/var/mail/cltbld', 03:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:40 INFO - 'MOZ_NO_REMOTE': '1', 03:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:40 INFO - 'NO_EM_RESTART': '1', 03:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:40 INFO - 'PWD': '/builds/slave/test', 03:40:40 INFO - 'SHELL': '/bin/bash', 03:40:40 INFO - 'SHLVL': '1', 03:40:40 INFO - 'TERM': 'linux', 03:40:40 INFO - 'TMOUT': '86400', 03:40:40 INFO - 'USER': 'cltbld', 03:40:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', 03:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:40 INFO - '_': '/tools/buildbot/bin/python'} 03:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:40:40 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 03:40:40 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 03:40:40 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 03:40:40 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 03:40:40 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 03:40:40 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 03:40:42 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40:43 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 03:40:43 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 03:40:43 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 03:40:43 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 03:40:43 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 03:40:43 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 03:40:43 INFO - Downloading docopt-0.6.1.tar.gz 03:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:43 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:43 INFO - Running setup.py install for blobuploader 03:40:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:43 INFO - Running setup.py install for requests 03:40:43 INFO - Running setup.py install for docopt 03:40:44 INFO - Successfully installed blobuploader requests docopt 03:40:44 INFO - Cleaning up... 03:40:44 INFO - Return code: 0 03:40:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:44 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 0x7fdabdf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c1c0>, '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 0x244d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', '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 03:40:44 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 03:40:44 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 03:40:44 INFO - Using env: {'DISPLAY': ':0', 03:40:44 INFO - 'HOME': '/home/cltbld', 03:40:44 INFO - 'LANG': 'en_US.UTF-8', 03:40:44 INFO - 'LANGUAGE': 'en_US:en', 03:40:44 INFO - 'LOGNAME': 'cltbld', 03:40:44 INFO - 'MAIL': '/var/mail/cltbld', 03:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:44 INFO - 'MOZ_NO_REMOTE': '1', 03:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:44 INFO - 'NO_EM_RESTART': '1', 03:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:44 INFO - 'PWD': '/builds/slave/test', 03:40:44 INFO - 'SHELL': '/bin/bash', 03:40:44 INFO - 'SHLVL': '1', 03:40:44 INFO - 'TERM': 'linux', 03:40:44 INFO - 'TMOUT': '86400', 03:40:44 INFO - 'USER': 'cltbld', 03:40:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', 03:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:44 INFO - '_': '/tools/buildbot/bin/python'} 03:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:44 INFO - Running setup.py (path:/tmp/pip-LB3fUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:44 INFO - Running setup.py (path:/tmp/pip-YnPDCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:44 INFO - Running setup.py (path:/tmp/pip-SgkXQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:44 INFO - Running setup.py (path:/tmp/pip-4N7FHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:44 INFO - Running setup.py (path:/tmp/pip-wZ8tA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:44 INFO - Running setup.py (path:/tmp/pip-8MKpU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:44 INFO - Running setup.py (path:/tmp/pip-lUUOPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:44 INFO - Running setup.py (path:/tmp/pip-GWKk21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:44 INFO - Running setup.py (path:/tmp/pip-3iwcz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:44 INFO - Running setup.py (path:/tmp/pip-mlLrK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:45 INFO - Running setup.py (path:/tmp/pip-GvHNn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:45 INFO - Running setup.py (path:/tmp/pip-SBAN9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:45 INFO - Running setup.py (path:/tmp/pip-M2t7K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:45 INFO - Running setup.py (path:/tmp/pip-nuogsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:45 INFO - Running setup.py (path:/tmp/pip-CQz3qR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:45 INFO - Running setup.py (path:/tmp/pip-79ouaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:45 INFO - Running setup.py (path:/tmp/pip-sIb4YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:45 INFO - Running setup.py install for manifestparser 03:40:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:45 INFO - Running setup.py install for mozcrash 03:40:45 INFO - Running setup.py install for mozdebug 03:40:45 INFO - Running setup.py install for mozdevice 03:40:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:40:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:45 INFO - Running setup.py install for mozfile 03:40:46 INFO - Running setup.py install for mozhttpd 03:40:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Running setup.py install for mozinfo 03:40:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Running setup.py install for mozInstall 03:40:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Running setup.py install for mozleak 03:40:46 INFO - Running setup.py install for mozlog 03:40:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Running setup.py install for moznetwork 03:40:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Running setup.py install for mozprocess 03:40:46 INFO - Running setup.py install for mozprofile 03:40:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Running setup.py install for mozrunner 03:40:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:46 INFO - Running setup.py install for mozscreenshot 03:40:47 INFO - Running setup.py install for moztest 03:40:47 INFO - Running setup.py install for mozversion 03:40:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:47 INFO - Cleaning up... 03:40:47 INFO - Return code: 0 03:40:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:47 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 0x7fdabdf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c1c0>, '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 0x244d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', '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 03:40:47 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 03:40:47 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 03:40:47 INFO - Using env: {'DISPLAY': ':0', 03:40:47 INFO - 'HOME': '/home/cltbld', 03:40:47 INFO - 'LANG': 'en_US.UTF-8', 03:40:47 INFO - 'LANGUAGE': 'en_US:en', 03:40:47 INFO - 'LOGNAME': 'cltbld', 03:40:47 INFO - 'MAIL': '/var/mail/cltbld', 03:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:47 INFO - 'MOZ_NO_REMOTE': '1', 03:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:47 INFO - 'NO_EM_RESTART': '1', 03:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:47 INFO - 'PWD': '/builds/slave/test', 03:40:47 INFO - 'SHELL': '/bin/bash', 03:40:47 INFO - 'SHLVL': '1', 03:40:47 INFO - 'TERM': 'linux', 03:40:47 INFO - 'TMOUT': '86400', 03:40:47 INFO - 'USER': 'cltbld', 03:40:47 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', 03:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:47 INFO - '_': '/tools/buildbot/bin/python'} 03:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:47 INFO - Running setup.py (path:/tmp/pip-mxfSrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:47 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)) 03:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:47 INFO - Running setup.py (path:/tmp/pip-oycbgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:47 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)) 03:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:47 INFO - Running setup.py (path:/tmp/pip-E5LW41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:47 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)) 03:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:47 INFO - Running setup.py (path:/tmp/pip-Z_uU3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:47 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)) 03:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:47 INFO - Running setup.py (path:/tmp/pip-mXm7E6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:47 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)) 03:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:47 INFO - Running setup.py (path:/tmp/pip-FL9sqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:47 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)) 03:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:47 INFO - Running setup.py (path:/tmp/pip-1a2zcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:48 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)) 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:48 INFO - Running setup.py (path:/tmp/pip-w2YV9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:48 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)) 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:48 INFO - Running setup.py (path:/tmp/pip-d8bSJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:48 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)) 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:48 INFO - Running setup.py (path:/tmp/pip-O6jDx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:48 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)) 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:48 INFO - Running setup.py (path:/tmp/pip-QzppoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:48 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)) 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:48 INFO - Running setup.py (path:/tmp/pip-suJRim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:48 INFO - Running setup.py (path:/tmp/pip-t2384y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:48 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)) 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:48 INFO - Running setup.py (path:/tmp/pip-cILJKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:48 INFO - Running setup.py (path:/tmp/pip-9STiyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:48 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)) 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:48 INFO - Running setup.py (path:/tmp/pip-7MGsh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:48 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)) 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:48 INFO - Running setup.py (path:/tmp/pip-OwBjE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:48 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)) 03:40:48 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)) 03:40:48 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)) 03:40:48 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)) 03:40:48 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)) 03:40:48 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)) 03:40:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:48 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 03:40:48 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 03:40:48 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 03:40:48 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 03:40:48 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 03:40:48 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 03:40:50 INFO - Downloading blessings-1.6.tar.gz 03:40:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:50 INFO - Installing collected packages: blessings 03:40:50 INFO - Running setup.py install for blessings 03:40:50 INFO - Successfully installed blessings 03:40:50 INFO - Cleaning up... 03:40:50 INFO - Return code: 0 03:40:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:51 INFO - Reading from file tmpfile_stdout 03:40:51 INFO - Current package versions: 03:40:51 INFO - argparse == 1.2.1 03:40:51 INFO - blessings == 1.6 03:40:51 INFO - blobuploader == 1.2.4 03:40:51 INFO - docopt == 0.6.1 03:40:51 INFO - functools32 == 3.2.3-2 03:40:51 INFO - jsonschema == 2.5.1 03:40:51 INFO - manifestparser == 1.1 03:40:51 INFO - mozInstall == 1.12 03:40:51 INFO - mozcrash == 0.17 03:40:51 INFO - mozdebug == 0.1 03:40:51 INFO - mozdevice == 0.48 03:40:51 INFO - mozfile == 1.2 03:40:51 INFO - mozhttpd == 0.7 03:40:51 INFO - mozinfo == 0.9 03:40:51 INFO - mozleak == 0.1 03:40:51 INFO - mozlog == 3.2 03:40:51 INFO - moznetwork == 0.27 03:40:51 INFO - mozprocess == 0.23 03:40:51 INFO - mozprofile == 0.28 03:40:51 INFO - mozrunner == 6.12 03:40:51 INFO - mozscreenshot == 0.1 03:40:51 INFO - mozsystemmonitor == 0.3 03:40:51 INFO - moztest == 0.7 03:40:51 INFO - mozversion == 1.4 03:40:51 INFO - psutil == 3.1.1 03:40:51 INFO - requests == 1.2.3 03:40:51 INFO - wsgiref == 0.1.2 03:40:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:51 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 0x7fdabdf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c1c0>, '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 0x244d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', '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 03:40:51 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 03:40:51 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 03:40:51 INFO - Using env: {'DISPLAY': ':0', 03:40:51 INFO - 'HOME': '/home/cltbld', 03:40:51 INFO - 'LANG': 'en_US.UTF-8', 03:40:51 INFO - 'LANGUAGE': 'en_US:en', 03:40:51 INFO - 'LOGNAME': 'cltbld', 03:40:51 INFO - 'MAIL': '/var/mail/cltbld', 03:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:51 INFO - 'MOZ_NO_REMOTE': '1', 03:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:51 INFO - 'NO_EM_RESTART': '1', 03:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:51 INFO - 'PWD': '/builds/slave/test', 03:40:51 INFO - 'SHELL': '/bin/bash', 03:40:51 INFO - 'SHLVL': '1', 03:40:51 INFO - 'TERM': 'linux', 03:40:51 INFO - 'TMOUT': '86400', 03:40:51 INFO - 'USER': 'cltbld', 03:40:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', 03:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:51 INFO - '_': '/tools/buildbot/bin/python'} 03:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:51 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)) 03:40:51 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)) 03:40:51 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)) 03:40:51 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)) 03:40:51 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)) 03:40:51 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)) 03:40:51 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)) 03:40:51 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)) 03:40:51 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)) 03:40:51 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)) 03:40:51 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)) 03:40:51 INFO - Cleaning up... 03:40:51 INFO - Return code: 0 03:40:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:51 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 0x7fdabdf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c1c0>, '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 0x244d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', '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 03:40:51 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 03:40:51 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 03:40:51 INFO - Using env: {'DISPLAY': ':0', 03:40:51 INFO - 'HOME': '/home/cltbld', 03:40:51 INFO - 'LANG': 'en_US.UTF-8', 03:40:51 INFO - 'LANGUAGE': 'en_US:en', 03:40:51 INFO - 'LOGNAME': 'cltbld', 03:40:51 INFO - 'MAIL': '/var/mail/cltbld', 03:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:51 INFO - 'MOZ_NO_REMOTE': '1', 03:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:51 INFO - 'NO_EM_RESTART': '1', 03:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:51 INFO - 'PWD': '/builds/slave/test', 03:40:51 INFO - 'SHELL': '/bin/bash', 03:40:51 INFO - 'SHLVL': '1', 03:40:51 INFO - 'TERM': 'linux', 03:40:51 INFO - 'TMOUT': '86400', 03:40:51 INFO - 'USER': 'cltbld', 03:40:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', 03:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:51 INFO - '_': '/tools/buildbot/bin/python'} 03:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:40:51 INFO - Cleaning up... 03:40:51 INFO - Return code: 0 03:40:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:51 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 0x7fdabdf10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c1c0>, '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 0x244d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', '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 03:40:51 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 03:40:51 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 03:40:51 INFO - Using env: {'DISPLAY': ':0', 03:40:51 INFO - 'HOME': '/home/cltbld', 03:40:51 INFO - 'LANG': 'en_US.UTF-8', 03:40:51 INFO - 'LANGUAGE': 'en_US:en', 03:40:51 INFO - 'LOGNAME': 'cltbld', 03:40:51 INFO - 'MAIL': '/var/mail/cltbld', 03:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:51 INFO - 'MOZ_NO_REMOTE': '1', 03:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:51 INFO - 'NO_EM_RESTART': '1', 03:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:51 INFO - 'PWD': '/builds/slave/test', 03:40:51 INFO - 'SHELL': '/bin/bash', 03:40:51 INFO - 'SHLVL': '1', 03:40:51 INFO - 'TERM': 'linux', 03:40:51 INFO - 'TMOUT': '86400', 03:40:51 INFO - 'USER': 'cltbld', 03:40:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', 03:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:51 INFO - '_': '/tools/buildbot/bin/python'} 03:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:51 INFO - Downloading/unpacking flake8 03:40:51 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 03:40:51 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 03:40:51 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 03:40:51 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 03:40:51 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 03:40:51 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 03:40:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:40:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:40:53 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 03:40:53 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 03:40:53 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 03:40:53 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 03:40:53 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 03:40:53 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 03:40:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:40:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:40:53 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 03:40:53 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 03:40:53 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 03:40:53 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 03:40:53 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 03:40:53 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 03:40:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:40:54 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 03:40:54 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 03:40:54 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 03:40:54 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 03:40:54 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 03:40:54 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 03:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:40:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:54 INFO - no previously-included directories found matching 'docs/_build' 03:40:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:40:54 INFO - Running setup.py install for pep8 03:40:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:54 INFO - no previously-included directories found matching 'docs/_build' 03:40:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:40:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:40:54 INFO - Cleaning up... 03:40:54 INFO - Return code: 0 03:40:54 INFO - Running post-action listener: _resource_record_post_action 03:40:54 INFO - Running post-action listener: _start_resource_monitoring 03:40:54 INFO - Starting resource monitoring. 03:40:54 INFO - ##### 03:40:54 INFO - ##### Finished create-virtualenv step (success) 03:40:54 INFO - ##### 03:40:54 INFO - ##### 03:40:54 INFO - ##### Running install step. 03:40:54 INFO - ##### 03:40:54 INFO - Running pre-action listener: _resource_record_pre_action 03:40:54 INFO - Running main action method: install 03:40:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:54 INFO - Reading from file tmpfile_stdout 03:40:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:54 INFO - Reading from file tmpfile_stdout 03:40:54 INFO - Output received: 03:40:54 INFO - Usage: mozinstall [options] installer 03:40:54 INFO - Options: 03:40:54 INFO - -h, --help show this help message and exit 03:40:54 INFO - -d DEST, --destination=DEST 03:40:54 INFO - Directory to install application into. [default: 03:40:54 INFO - "/builds/slave/test"] 03:40:54 INFO - --app=APP Application being installed. [default: firefox] 03:40:54 INFO - mkdir: /builds/slave/test/build/application 03:40:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:41:10 INFO - Reading from file tmpfile_stdout 03:41:10 INFO - Output received: 03:41:10 INFO - /builds/slave/test/build/application/firefox/firefox 03:41:10 INFO - Running post-action listener: _resource_record_post_action 03:41:10 INFO - ##### 03:41:10 INFO - ##### Finished install step (success) 03:41:10 INFO - ##### 03:41:10 INFO - ##### 03:41:10 INFO - ##### Running run-tests step. 03:41:10 INFO - ##### 03:41:10 INFO - Running pre-action listener: _resource_record_pre_action 03:41:10 INFO - Running main action method: run_tests 03:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:10 INFO - Python 2.7.3 03:41:10 INFO - Return code: 0 03:41:10 INFO - grabbing minidump binary from tooltool 03:41:10 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')]} 03:41:10 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 0x244c1c0>, '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 0x244d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41:10 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 03:41:10 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 03:41:10 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 03:41:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:10 INFO - Return code: 0 03:41:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:41:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:41:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:41:11 INFO - Return code: 0 03:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 03:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 03:41:11 INFO - Using env: {'DISPLAY': ':0', 03:41:11 INFO - 'HOME': '/home/cltbld', 03:41:11 INFO - 'LANG': 'en_US.UTF-8', 03:41:11 INFO - 'LANGUAGE': 'en_US:en', 03:41:11 INFO - 'LOGNAME': 'cltbld', 03:41:11 INFO - 'MAIL': '/var/mail/cltbld', 03:41:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:11 INFO - 'MOZ_NO_REMOTE': '1', 03:41:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:11 INFO - 'NO_EM_RESTART': '1', 03:41:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:11 INFO - 'PWD': '/builds/slave/test', 03:41:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:11 INFO - 'SHELL': '/bin/bash', 03:41:11 INFO - 'SHLVL': '1', 03:41:11 INFO - 'TERM': 'linux', 03:41:11 INFO - 'TMOUT': '86400', 03:41:11 INFO - 'USER': 'cltbld', 03:41:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247', 03:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:11 INFO - '_': '/tools/buildbot/bin/python'} 03:41:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 03:41:11 INFO - mozversion application_buildid: 20160731234823 03:41:11 INFO - mozversion application_changeset: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff 03:41:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:41:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:11 INFO - mozversion application_name: Firefox 03:41:11 INFO - mozversion application_remotingname: firefox-dev 03:41:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:11 INFO - mozversion application_vendor: Mozilla 03:41:11 INFO - mozversion application_version: 49.0a2 03:41:11 INFO - mozversion platform_buildid: 20160731234823 03:41:11 INFO - mozversion platform_changeset: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff 03:41:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:11 INFO - mozversion platform_version: 49.0a2 03:41:11 INFO - using testdate: 1470048071 03:41:11 INFO - actual date: 1470048071 03:41:11 INFO - starting webserver on 'localhost:60820' 03:41:11 INFO - SUITE-START | Running 2 tests 03:41:11 INFO - TEST-START | dromaeo_css 03:41:11 INFO - operating with platform_type : linux_ 03:41:11 INFO - Initialising browser for dromaeo_css test... 03:41:11 INFO - TEST-INFO | started process 15820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQai40J/profile http://localhost:60820/getInfo.html) 03:41:15 INFO - PROCESS | 15820 | __metrics Screen width/height:1600/1200 03:41:15 INFO - PROCESS | 15820 | colorDepth:24 03:41:15 INFO - PROCESS | 15820 | Browser inner width/height: 1024/697 03:41:15 INFO - PROCESS | 15820 | __metrics 03:41:16 INFO - PROCESS | 15820 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:41:16 ERROR - PROCESS | 15820 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:41:17 INFO - TEST-INFO | 15820: exit 0 03:41:17 INFO - Browser initialized. 03:41:17 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:17 INFO - TEST-INFO | started process 15910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQai40J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:29 INFO - PROCESS | 15910 | RSS: Main: 142225408 03:41:29 INFO - PROCESS | 15910 | 03:42:20 INFO - PROCESS | 15910 | 1470048140032 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] 03:44:28 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:60820/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60820/tests/dromaeo/cssquery-ext.html) 03:44:29 INFO - PROCESS | 15910 | RSS: Main: 250753024 03:44:29 INFO - PROCESS | 15910 | 03:47:31 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:60820/tests/dromaeo/cssquery-ext.html (next: http://localhost:60820/tests/dromaeo/cssquery-jquery.html) 03:47:32 INFO - PROCESS | 15910 | RSS: Main: 228450304 03:47:32 INFO - PROCESS | 15910 | 03:50:34 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:60820/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60820/tests/dromaeo/cssquery-mootools.html) 03:50:34 INFO - PROCESS | 15910 | RSS: Main: 225742848 03:50:34 INFO - PROCESS | 15910 | 03:53:36 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:60820/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60820/tests/dromaeo/cssquery-prototype.html) 03:53:37 INFO - PROCESS | 15910 | RSS: Main: 220188672 03:53:37 INFO - PROCESS | 15910 | 03:56:40 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:60820/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60820/tests/dromaeo/cssquery-yui.html) 03:56:40 INFO - PROCESS | 15910 | RSS: Main: 202457088 03:56:40 INFO - PROCESS | 15910 | 03:59:43 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:60820/tests/dromaeo/cssquery-yui.html (next: http://localhost:60820/tests/dromaeo/cssquery-dojo.html) 03:59:43 INFO - PROCESS | 15910 | RSS: Main: 258375680 03:59:43 INFO - PROCESS | 15910 | 03:59:43 INFO - PROCESS | 15910 | __start_tp_report 03:59:43 INFO - PROCESS | 15910 | _x_x_mozilla_page_load 03:59:43 INFO - PROCESS | 15910 | _x_x_mozilla_page_load_details 03:59:43 INFO - PROCESS | 15910 | |i|pagename|runs| 03:59:43 INFO - PROCESS | 15910 | |0;dojo.html;3380.9492857607133;3394.9490757638623;3405.659434056593;3409.676080772326;3433.811140387281;5561.5828812839045;5584.609077364581;5601.6358936669085;5608.158776183574;5624.128260119678;5496.725163741807;5555.8888822223635;5561.610687251884;5569.081101618228;5597.608167428281;4953.900921981558;4963.478834722357;5030.572401345881;5047.394312682483;5095.6178286628465;4993.5755460785695;4994.525520075587;5011.624128190382;5022.522860328263;5086.898262034757;5118.181091025437;5123.129068058421;5131.923021154686;5133.614978876599;5160.483951604847;5124.92312615311;5125.154349532323;5128.4102328232175;5135.691858488465;5167.250748641426;4912.70523768575;4923.483034281385;4973.403191616993;5024.723640199788;5040.042391945555;5296.25852380667;5331.147016477384;5372.462753724635;5377.489138531833;5384.703841288728;5901.645901245939;5908.438698323653;5948.078047902582;5954.761809527614;5965.4332838380715;5677.148427735831;5746.080627099644;5759.798407055733;5895;5911.940880591182;5471.835844924619;5486.361502581881;5520.944790552083;5546.889062218814;5574.219609254748;6056.424639659225;6070.3929607038945;6072.544559158081;6073.331933487313;6084.5436592255755;5604.523615492729;5759.65442073477;5835.35811060783;5842.357340692605;5915.201447804578;5922.378150294243;5955.821325360246;5965.313988891333;6006.669633170218;6008.849778755566;5749.913751293734;5916.763329466773;5927.525797936241;5939.732712027969;5942.524598032147;5818.359980402152;5862.912056319158;5883.323417807007;5901.232839730807;5920.052791553417;4550.47669518003;4550.817967281272;4552.931706024346;4555.931661025087;4584.33527138563;3966.1671049080014;4005.539362973237;4086.734362266443;4094.4472496213225;4120.340745480708;5708.372079071299;5738.139279108167;5755.884882302331;5762.855928601734;5795.507381872504;5950.702464876826;5952.255968003999;5959.910601340984;6015.0676645120075;6019.398060193946;5526.198701188305;5660.179274005329;5670.688112153789;5726.685032323262;5741.25363702716;5121.027004869063;5124.718140502234;5124.8206312778875;5126.15418455958;5146.047981123429;6200.3799620037635;6247.718852651642;6249.25008998923;6250;6263.154474145932;5731.054376027909;5898.174255604133;5964.284285885721;5967.49276311501;5980.3421623622235;6273.749050037947;6301.842453938688;6302.968485157545;6311.873762524816;6327.746890124344;5847.093700476433;5891.793787217427;5911.704414779329;5913.497352724895;5939.4357536034;5897.64614123154;5899;5937.871804357158;5971.164037034731;6019.127226552037;5888.116782482662;5893.263342082239;5893.882122357443;5895.793647222326;5897.292324921037;5676.035074037506;5804.854878628068;5854.648721076749;5866.384029676993;5866.6480011199465;5578.442155784389;5590.692511911721;5593.804216852391;5616.045272303636;5622.746976385991;5769.538436924952;5779;5780.277465316835;5823.912641310469;5834.795782147605;5577.972110139423;5582.441755824385;5661.037623604079;5667.5465962722055;5698.686572238566 03:59:43 INFO - PROCESS | 15910 | |1;ext.html;592.0822724776596;640.1358166475256;645.5190882792319;655.2104713819848;658.8682263547289;32080.67919320806;44635.77682111593;45871.54128458715;45965.310520342224;46014;48287;48891;48920.51079489204;48954;49065.75467122659;8237;9098.13567711068;9222.170004699576;10713.625023124192;10958.945205274002;10972.561097556088;11071.501782419811;11076.944615276952;11079.113670906348;11081.944590277037;11069.50187241576;11114.444277786119;11122.165837562176;11122.443877806118;11128.109751219923;8320.875186872201;10665.946670266638;10931.945340273327;10944.3980581068;11336.943315283454;10891.183161262858;10961.12311015117;10978.780424391467;10985.450727463674;10996.835047474295;43657.56342436567;43729;43999.340009899875;44235.33646995298;44309.11381772379;3674.4855720199193;3770.6794922431627;3797.9240415191543;3992.960070399288;4459.439196281275;33398.666013339796;34213.14467138317;34436.655633443595;36515.452268215995;36957.07607309812;4643.233866412038;4704.788284527204;4747.786349614275;4793.3049707792525;4796.519604663821;417523;417789;418529;418723;419730;68495.65752171207;68504.3149568508;68887.65556172187;69020;69024.6548767253;38951.80524097361;39775.2044959105;39898.40152397716;41592;41767.582324176976;17509.824901751075;18306.17622207004;18364.540886477676;18497.33523982848;18525.53686157857;14502.419903203754;14592.927035364755;14628.926855365868;14951.252437378087;15003.474878379204;20285.188592456136;20380.184792608427;20541.691874621894;20615.896920515603;20655.380338589865;7265.709371625076;7370.410367170613;7421.888671669929;7442.255774422514;7524.887126692995;958.4297343080856;1014.9035841595037;1074.6990842564094;1128.90968722502;1138.834868944015;33756.32487350288;34086.659133408844;34391.312173756385;34520.654793452246;34704.479432808526;1008.5124441448804;1157.2073129906041;1167.287954347847;1194.8386967759416;1252.2486508095253;17850.642987140185;18037.7294340585;18056.909715451602;18112.909435453003;18296.908515457337;625649;630098;630982;631498;631521;64846.35153648497;64884.67557662181;65574.34425655683;65649.34350656527;65753.04111315003;1369.486442584031;1423.9145651261165;1431.291510702209;1440.6038339456734;1461.6126726417508;31740;34487.137821554665;34671.30657386889;34787.652123479456;34813.82593087119;52851.471485286194;54055.72972135114;54109;54179.72910135424;54197.45802541924;449674;459467;460236;460289;461834;27030.864845675645;29548.704512954595;29789.851050744608;30126.698733013265;30307.242318942204;51111;51692.74153629358;52202.73898630482;53554;55295.44704552903;44195;44521.33218001798;44669.77665111654;45213.77393113145;45463;44372.77813610911;44854.3271850916;45197.09337049546;45771.31343029791;45909.31136033029;44582.777086114365;45185.548144519445;45621;45786.77106614579;45919;37354.8132259337;38192;38265.80867095647;39110.217795644494;39330.2133957325;30062.54906176453;30138.69861301359;30198.245043874078;30207.69792302049;30310 03:59:43 INFO - PROCESS | 15910 | |2;jquery.html;422.89427643089226;427.82459191731385;430.09250481484065;430.21056361576507;441.5165393893685;18780.90609546952;19451.513712157204;20107.899460502715;20265.797342026577;20285.797142028612;19657.901710491427;20026.59946801063;20136;20355.185792568318;20454.488637784063;5591.4688104629995;5775.624584402021;5819.214406055192;5820.068788993762;5823.039198532237;4089.591040895916;4104.384342348641;5724.742386592592;5776.653400795944;6123.846903827418;6359.046143078552;6416.3262857400005;6460.224773027243;6465.062565927938;6467.126937863375;6332.588381755218;6366.522510811685;6438.45273151778;6438.806835794933;6444.774432894873;3829.5021647185968;5343.946560534423;5706.087026075849;5847.619904706181;5861.882762344771;23672.881635591883;23914.521709565885;23942.042318307245;24080.759192408026;24161.275161745;2454.361865914875;2974.1672331746927;3061.4642437573557;3128.405602935458;3189.04328701391;13924.37340319688;14485.565433037025;14493.565193044225;14813.629659258497;15243.695126097527;1981.0589969764392;2092.309537852505;2129.744430668314;2150.731158605174;2163.1131236193087;64241.15806566602;90656.09343906608;90803.54598227033;91075.54462227713;91823;11389.658310250707;11398.601048963246;11544.76910461786;11756.70608234801;12077.698057548632;16697;16739;16836.24236909342;16839.831601684073;16841.747373789403;8355;8671.696490622799;8825.779355516164;8845.867311990325;8948.910510894808;8622.137786221328;8682.913170868336;8719.60761765722;8761.167689069529;8866.822663546693;4859.2954021666665;4917.065757506062;4951.603871690256;4962.082014827269;5144.511271429208;2049.6413127702594;2072.367927782041;2091.5607722378168;2110.6939493773625;2111.1766411099684;930.5114814722325;1018.7453136715822;1036.1194432105704;1076.2091204499632;1133.8582677165355;19647.312344068174;19791.505212369804;20013;20035.39893803188;20212.393628191177;1021.1626466297565;1031.4636389077637;1062.9946850265699;1076.3864597179688;1092.5520536579963;10740.946295268473;10941;11019.779604407868;11141.442927853575;11306.830397544043;522065;532468;535483;551352;551799;93883;95249;98018.50990745143;98157;98298;1045.5765415006933;1069.1927594665976;1075.2526993739432;1080.8432777247413;1088.9618863339745;17104.230309636347;17139.400120996204;17462;17465.650686986442;17624.55938601494;38922.6107738919;39838.402423964246;39987.200255995296;41219.58780412158;43626;56237.43762562322;58077.709611451675;62958;64008.3599164021;65967.67016164889;7987.361011119213;8035.758927232192;8330.666773329;8356.665733370597;8994.955025224832;9942.850857237292;13339.86660133425;13420;13551.119177253448;13564.525241616891;11503.712407189887;11687.824682629938;11744.58893938708;11787.941060294643;11856.76286474283;6102.0541816018585;10853.480512728382;11548.538058477567;11646.95177434035;11665.183437159318;12056.872227329086;12207.328596927255;12243.20419172751;12256.754864902474;12279.938600306941;8118.675252989814;8280.627371768405;8340;8340.87488687658;8515.616797244264;9185.77035574116;11261.155413343868;12287.44706488228;12292.569760058355;12406.565770198 03:59:43 INFO - PROCESS | 15910 | |3;mootools.html;1406.282795774155;1582.050769538277;1626.4957863062452;1821.408042386224;1949.4541528372051;8994.820103597924;9329.300302477308;9338.859917101241;9349.439033657985;9553.092456216647;9163.95418022909;9427.95286023569;9614.95192524038;9624.80750384992;9634.373765705242;2111.5671287386126;2480.417101981033;2486.2292689266296;2535.911243106492;2552.52778236026;2501.687289088864;2513.7234904160528;2522.230719630512;2523.8864251108744;2525.9242222733346;2474.9010039598393;2487.6517287579754;2488.950220995579;2491.501699660066;2492.7881130103965;2137.091736012196;2421.225207933462;2485.6644353012293;2490.713567939692;2502.78726308264;2458.0659349447274;2475.10896077412;2483.4412257242157;2526.4315529005826;2528.266802627236;9441.858372124423;9447.149756521945;9450.19673327768;9482.762930926712;9502;5657.32112146545;5795.217645617872;5797.304323481209;5802.390748971339;5802.651840889518;3603.369410353204;3613.9277214455565;3698.389765688658;3732.2908647357185;3748.212875296191;1296.274086511547;1304.3543445994198;1322.7883538633869;1328.2296268164441;1353.147517064253;13661.18032918028;13901.165930044128;13919.164850108924;13978.720425591431;13987.580372588838;5135.075686376414;5140.203268493389;5192;5199.064168449715;5207.661502002357;11711.004564612103;11732;11740.295582265091;11774.88225117755;11778.88221117795;5015.799368025238;5829.5044921181325;5836.795712150054;5843.298804143445;5844.912326315109;5142.794288228429;5266.420693723688;5271.051210782096;5302.602304827076;5305.442928492453;4415.602595766396;4428.446444194476;4454.821807127743;4494.0337827367275;4504.6396288296855;1350.216874212954;1380.8688174623394;1384.4669802126052;1394.6861956059806;1411.2520364206987;894.7807787092204;938.4275591888942;991.2268430624125;1051.894810518942;1071.6570697376922;6363.427291543783;6378.521610879203;6539.280679125292;6571.507136964651;6610.570312929644;504.4955044955045;505.0958783776998;505.858359659296;1087.8694556653252;1104.1718710966775;4387.802548885308;4439.378487011821;4439.4006809080365;4493.1013797240685;4502.414686090853;12055.336956467478;12428.875711242952;12431.813522797165;12438.937805310916;12478.376081195904;11723.589674361356;12049.578264760692;12127.393630318626;12306.323152226714;12460.065495087905;8891.510966896753;8982.371234013557;9003.594838232295;9019.098090190928;9030.86453703195;6467.935320646921;6583.63789991555;6724.747349031673;6834.760783372558;6885.758998435031;10878;10936.781264374828;11187;11527.769444610893;11569.595064172714;11164.106871450102;11580.710482238012;11594.47824847867;11702.70743231392;11809.05527557776;7721.150673425806;8485.151484851465;8655.307575393828;8731.170538798804;8787.91212087871;9554.474503902075;9612.51937403113;9648.421094734058;9705.417674939526;9714;8382.533056714929;8596.269317108116;8608.139186081593;8702.82594348122;8765.34259930495;8266.751997440086;8349.165083491846;8396.118407567361;8426.4944103354;8471.915280847114;7804.84390312202;7822.374210063067;7928.841423171389;7931.325837303893;7934.444588878723;5675.545956323402;5714.771409143587;5726.198332233574;5747.511461525817;5861.384554621874;5345.732713364238;5409.783608655767;5547.722613869371;5634.0422128239115;5648.830535083954 03:59:43 INFO - PROCESS | 15910 | |4;prototype.html;341.0348713141809;347.1027394186029;353.91682954505694;355.3284292686821;356;5336.252924590555;5478.616496845218;5478.876830249799;5491.203775452557;5494.587905907053;5366.09503626213;5389;5424.620276580641;5439.5104440600335;5444.292242008533;4092.0997380576373;4240.851570195044;4246.723962942414;4271.594198551133;4276.294411422112;4201.453811004565;4207.200631879949;4214.852480163195;4230.830766769341;4242.8727138185905;4011.6761468715254;4189.518205406372;4215;4221.176870510251;4250.341197114437;4092.4270602115726;4182.2890108681595;4184.748915065075;4190.266703326905;4211.789410529492;3728.6830619397383;3755.7746535207702;3770.9434358484646;3771.679407250387;3786.091338078869;4954.950450495521;5078.187490001619;5176.404713457963;5185.22221666753;5207.6354655174155;4488.079943611585;4760.785764640565;4782.426108866924;4793.496682848286;4798.928016079762;5540.972295138539;5569.359523654791;5584.804531841366;5611.579131565108;5634.352049514277;3940.783256920868;4054.945714114322;4075.49056367954;4087.693422993287;4104.630583247522;5772.7113644317615;5780.277465316835;5781.71091445426;5788.739506722165;5791.5656325775735;4137.379393091001;4154.605312495308;4162.771047592351;4182.205380977604;4185.97907010463;3995.580464051291;4178.35235538492;4236.788160591958;4251.9787401062795;4258.508772368137;4684.882877928079;4693.389859318335;4803.855884323476;4816.15717249487;4822.180229361017;5572.5263352614675;5575.1915972184615;5608.327000759935;5616.550675945915;5629.819152179006;1392.554382597559;1434.419060280588;1435.9445807331604;1448.4857875454272;1458.1688437590683;900.7973206028591;906.2930913887178;913.8766266554063;926.305271046715;931.4783721116197;4870.366852309248;4967;4990.203526730446;4996.225585034325;4998.875477921869;5136.280920671109;5195.948040519622;5207.479252074762;5212.791488340424;5220.556252718486;5016.222485514678;5336.67979921206;5362.3565172178805;5458.754356053987;5514.91727624086;3030.9848450757604;3072.75553400873;3074.8462576871066;3075.3234288456506;3087.027586310305;5877.94346939589;6069.180660610761;6120.724567394478;6142.232220972379;6149.169862068564;5810.535157187415;5842.357340692521;5845.210896528999;5869.735861886225;5882.529397648178;6001.339852616209;6015.699215039231;6045.6070355426755;6069.453749162597;6084.4828189603495;5638.562166647479;5738.196652468741;5767.798127065533;5773.1814478439155;5824.621399609012;5697.971510142423;5730.426957304237;5743.736377996834;5771.307443106686;5772.5381969441505;5815.360310365941;6069.757209711739;6113.5414843886;6122.908156377569;6158.445739883432;4107.178564287215;4173.749575025508;4185.727927684691;4186.455760751083;4203.726757760735;5791.710414479175;5805.564582656233;5833.708314584339;5854.560907931837;5879.529637629065;5639.238702775073;5640.717964101696;5691.516221121251;5705.630648644213;5762.30852297727;5666.401834834992;5668.744906479301;5673.319201695823;5694.943050569607;5698.886022279614;5474.534664553557;5635.267415236157;5645.012122878562;5650.830475085754;5650.915236271541;5685.175649530877;5688.890666320193;5748.770049197985;5750.539956803362;5765.155150352015;5361.597880158925;5555.972220138873;5576.91634625489;5581.581381396492;5593.244911936999 03:59:43 INFO - PROCESS | 15910 | |5;yui.html;707.1620130145777;739.8002539314385;751.1249394455459;772.8222508822971;817.1460823439508;15174.62063448413;16134.757978630301;16471.999999999985;16519.587010324747;17047.744283835753;15047.849521504782;15077.396904123849;15209.391624335041;15213.163276019815;15216.619584510392;724.3480867219492;838.8406202821475;853.0488505316574;858.9441686290403;862.2455351567379;846.7756044648173;851.586980314547;852.075498084579;855.7946092937713;856.1994535109692;900.6442455230213;901.0808974845653;901.8737376767258;901.9233365163936;902.2240872849344;757.8711619024779;874.4971641306242;897.0894542039835;897.4121950122681;899.8875140607424;663.5653646861314;663.9535232533725;664.3024823934849;664.4186336955164;664.8204984654164;15097.3206205721;15120.773188402183;15123.168225747579;15126.546203613909;15137.621559460991;14549.490767823181;14646.487372942003;14911;15248.771268430983;15249.161296128708;13308.667283317898;13355.265460399674;13392.531261405902;13497.2576508292;13511.391987360494;4537.886552836172;4654.0924519718665;4656.138614356321;4673.182193116191;4711.528847115295;78336.21663783403;78509.99999999943;78529.60735196345;78617.60691196565;78928;11227.943860280646;11255.099592032619;11429.771404571862;11439.199256052163;11730.178887477794;18403;18472.353467628836;18473.907630462032;18479.168437420347;18486.445406637824;8459.407841451162;8663.436876603;8814.603342849587;8921.776955576162;8979.057198994142;4661.627069834405;4724.771559394513;4747.311639812277;4820.108279968217;4821.783019764049;3507.8947631571095;3635.8727444539313;3642.5446819147605;3648.4709717090873;3648.543932008499;538.9110796718576;639.8144538083903;646.2697152217963;661.6625520984236;671.4997326991422;755.8412733326063;756.670848181043;757.3638143958991;759.4987308376556;775.158952536493;10794.838077428845;10808.78382432347;10888.67333979982;10983.560657573767;11147.21969462146;641;737.8118579762127;745.3627148787817;747.8055705516605;756.9280918312752;4997.150484417658;5116.155834287375;5121.155009423478;5204.635675502678;5224.843254702365;123237;126768;127508;134022.32988835187;134252.3287383557;105116.47441762743;108582.45708771405;109666.45166774275;109731.45134274277;110919;91917;97925;97941.02058979461;98429.50785246027;98858;9825.557849896915;9913.801723965624;9969.750756231153;10025;10060.899391005996;56232.156517653086;56809;56822.43177568171;58137;58262;65968.68062638624;67484.32515674976;67559;77484;82419.5879020625;13900.304984750925;14117.2941352934;14210.644733881736;14267;14393.208373539555;15057.774133388228;15299.541013769605;15467.922660386626;15592.636067814527;15902;10487.790244195226;10704.625338113128;10715.196360272856;11314;13967.301634918416;14428.711425771637;14769.409223630935;14794.482193123189;15190.316435760196;15513.301901414688;14866.776998344818;14909.25453727331;15164.545063648107;15283;15308.081515109128;11011.61459348951;11192.83210751823;11436.256643318158;11688.824667629822;11762.647120586396;11224.576504166307;11357.204995650225;11487.712807179887;11568;11578.594749183738 03:59:43 INFO - PROCESS | 15910 | __end_tp_report 03:59:43 INFO - PROCESS | 15910 | __start_cc_report 03:59:43 INFO - PROCESS | 15910 | _x_x_mozilla_cycle_collect,858 03:59:43 INFO - PROCESS | 15910 | __end_cc_report 03:59:43 INFO - PROCESS | 15910 | __startTimestamp1470049183535__endTimestamp 03:59:43 INFO - PROCESS | 15910 | 03:59:43 INFO - PROCESS | 15910 | ------- Summary: start ------- 03:59:43 INFO - PROCESS | 15910 | Number of tests: 6 03:59:43 INFO - PROCESS | 15910 | 03:59:43 INFO - PROCESS | 15910 | [#0] dojo.html Cycles:165 Average:5522.31 Median:5726.69 stddev:610.36 (10.7%) stddev-sans-first:588.66 03:59:43 INFO - PROCESS | 15910 | Values: 3380.9 3394.9 3405.7 3409.7 3433.8 5561.6 5584.6 5601.6 5608.2 5624.1 5496.7 5555.9 5561.6 5569.1 5597.6 4953.9 4963.5 5030.6 5047.4 5095.6 4993.6 4994.5 5011.6 5022.5 5086.9 5118.2 5123.1 5131.9 5133.6 5160.5 5124.9 5125.2 5128.4 5135.7 5167.3 4912.7 4923.5 4973.4 5024.7 5040.0 5296.3 5331.1 5372.5 5377.5 5384.7 5901.6 5908.4 5948.1 5954.8 5965.4 5677.1 5746.1 5759.8 5895.0 5911.9 5471.8 5486.4 5520.9 5546.9 5574.2 6056.4 6070.4 6072.5 6073.3 6084.5 5604.5 5759.7 5835.4 5842.4 5915.2 5922.4 5955.8 5965.3 6006.7 6008.8 5749.9 5916.8 5927.5 5939.7 5942.5 5818.4 5862.9 5883.3 5901.2 5920.1 4550.5 4550.8 4552.9 4555.9 4584.3 3966.2 4005.5 4086.7 4094.4 4120.3 5708.4 5738.1 5755.9 5762.9 5795.5 5950.7 5952.3 5959.9 6015.1 6019.4 5526.2 5660.2 5670.7 5726.7 5741.3 5121.0 5124.7 5124.8 5126.2 5146.0 6200.4 6247.7 6249.3 6250.0 6263.2 5731.1 5898.2 5964.3 5967.5 5980.3 6273.7 6301.8 6303.0 6311.9 6327.7 5847.1 5891.8 5911.7 5913.5 5939.4 5897.6 5899.0 5937.9 5971.2 6019.1 5888.1 5893.3 5893.9 5895.8 5897.3 5676.0 5804.9 5854.6 5866.4 5866.6 5578.4 5590.7 5593.8 5616.0 5622.7 5769.5 5779.0 5780.3 5823.9 5834.8 5578.0 5582.4 5661.0 5667.5 5698.7 03:59:43 INFO - PROCESS | 15910 | 03:59:43 INFO - PROCESS | 15910 | [#1] ext.html Cycles:180 Average:66824.27 Median:39836.80 stddev:135641.90 (340.5%) stddev-sans-first:135931.26 03:59:43 INFO - PROCESS | 15910 | Values: 592.1 640.1 645.5 655.2 658.9 32080.7 44635.8 45871.5 45965.3 46014.0 48287.0 48891.0 48920.5 48954.0 49065.8 8237.0 9098.1 9222.2 10713.6 10958.9 10972.6 11071.5 11076.9 11079.1 11081.9 11069.5 11114.4 11122.2 11122.4 11128.1 8320.9 10665.9 10931.9 10944.4 11336.9 10891.2 10961.1 10978.8 10985.5 10996.8 43657.6 43729.0 43999.3 44235.3 44309.1 3674.5 3770.7 3797.9 3993.0 4459.4 33398.7 34213.1 34436.7 36515.5 36957.1 4643.2 4704.8 4747.8 4793.3 4796.5 417523.0 417789.0 418529.0 418723.0 419730.0 68495.7 68504.3 68887.7 69020.0 69024.7 38951.8 39775.2 39898.4 41592.0 41767.6 17509.8 18306.2 18364.5 18497.3 18525.5 14502.4 14592.9 14628.9 14951.3 15003.5 20285.2 20380.2 20541.7 20615.9 20655.4 7265.7 7370.4 7421.9 7442.3 7524.9 958.4 1014.9 1074.7 1128.9 1138.8 33756.3 34086.7 34391.3 34520.7 34704.5 1008.5 1157.2 1167.3 1194.8 1252.2 17850.6 18037.7 18056.9 18112.9 18296.9 625649.0 630098.0 630982.0 631498.0 631521.0 64846.4 64884.7 65574.3 65649.3 65753.0 1369.5 1423.9 1431.3 1440.6 1461.6 31740.0 34487.1 34671.3 34787.7 34813.8 52851.5 54055.7 54109.0 54179.7 54197.5 449674.0 459467.0 460236.0 460289.0 461834.0 27030.9 29548.7 29789.9 30126.7 30307.2 51111.0 51692.7 52202.7 53554.0 55295.4 44195.0 44521.3 44669.8 45213.8 45463.0 44372.8 44854.3 45197.1 45771.3 45909.3 44582.8 45185.5 45621.0 45786.8 45919.0 37354.8 38192.0 38265.8 39110.2 39330.2 30062.5 30138.7 30198.2 30207.7 30310.0 03:59:43 INFO - PROCESS | 15910 | 03:59:43 INFO - PROCESS | 15910 | [#2] jquery.html Cycles:180 Average:30997.46 Median:13307.82 stddev:88747.76 (666.9%) stddev-sans-first:88967.02 03:59:43 INFO - PROCESS | 15910 | Values: 422.9 427.8 430.1 430.2 441.5 18780.9 19451.5 20107.9 20265.8 20285.8 19657.9 20026.6 20136.0 20355.2 20454.5 5591.5 5775.6 5819.2 5820.1 5823.0 4089.6 4104.4 5724.7 5776.7 6123.8 6359.0 6416.3 6460.2 6465.1 6467.1 6332.6 6366.5 6438.5 6438.8 6444.8 3829.5 5343.9 5706.1 5847.6 5861.9 23672.9 23914.5 23942.0 24080.8 24161.3 2454.4 2974.2 3061.5 3128.4 3189.0 13924.4 14485.6 14493.6 14813.6 15243.7 1981.1 2092.3 2129.7 2150.7 2163.1 64241.2 90656.1 90803.5 91075.5 91823.0 11389.7 11398.6 11544.8 11756.7 12077.7 16697.0 16739.0 16836.2 16839.8 16841.7 8355.0 8671.7 8825.8 8845.9 8948.9 8622.1 8682.9 8719.6 8761.2 8866.8 4859.3 4917.1 4951.6 4962.1 5144.5 2049.6 2072.4 2091.6 2110.7 2111.2 930.5 1018.7 1036.1 1076.2 1133.9 19647.3 19791.5 20013.0 20035.4 20212.4 1021.2 1031.5 1063.0 1076.4 1092.6 10740.9 10941.0 11019.8 11141.4 11306.8 522065.0 532468.0 535483.0 551352.0 551799.0 93883.0 95249.0 98018.5 98157.0 98298.0 1045.6 1069.2 1075.3 1080.8 1089.0 17104.2 17139.4 17462.0 17465.7 17624.6 38922.6 39838.4 39987.2 41219.6 43626.0 56237.4 58077.7 62958.0 64008.4 65967.7 7987.4 8035.8 8330.7 8356.7 8995.0 9942.9 13339.9 13420.0 13551.1 13564.5 11503.7 11687.8 11744.6 11787.9 11856.8 6102.1 10853.5 11548.5 11647.0 11665.2 12056.9 12207.3 12243.2 12256.8 12279.9 8118.7 8280.6 8340.0 8340.9 8515.6 9185.8 11261.2 12287.4 12292.6 12406.6 03:59:43 INFO - PROCESS | 15910 | 03:59:43 INFO - PROCESS | 15910 | [#3] mootools.html Cycles:180 Average:6404.46 Median:504.80 stddev:3721.51 (737.2%) stddev-sans-first:3713.00 03:59:43 INFO - PROCESS | 15910 | Values: 1406.3 1582.1 1626.5 1821.4 1949.5 8994.8 9329.3 9338.9 9349.4 9553.1 9164.0 9428.0 9615.0 9624.8 9634.4 2111.6 2480.4 2486.2 2535.9 2552.5 2501.7 2513.7 2522.2 2523.9 2525.9 2474.9 2487.7 2489.0 2491.5 2492.8 2137.1 2421.2 2485.7 2490.7 2502.8 2458.1 2475.1 2483.4 2526.4 2528.3 9441.9 9447.1 9450.2 9482.8 9502.0 5657.3 5795.2 5797.3 5802.4 5802.7 3603.4 3613.9 3698.4 3732.3 3748.2 1296.3 1304.4 1322.8 1328.2 1353.1 13661.2 13901.2 13919.2 13978.7 13987.6 5135.1 5140.2 5192.0 5199.1 5207.7 11711.0 11732.0 11740.3 11774.9 11778.9 5015.8 5829.5 5836.8 5843.3 5844.9 5142.8 5266.4 5271.1 5302.6 5305.4 4415.6 4428.4 4454.8 4494.0 4504.6 1350.2 1380.9 1384.5 1394.7 1411.3 894.8 938.4 991.2 1051.9 1071.7 6363.4 6378.5 6539.3 6571.5 6610.6 504.5 505.1 505.9 1087.9 1104.2 4387.8 4439.4 4439.4 4493.1 4502.4 12055.3 12428.9 12431.8 12438.9 12478.4 11723.6 12049.6 12127.4 12306.3 12460.1 8891.5 8982.4 9003.6 9019.1 9030.9 6467.9 6583.6 6724.7 6834.8 6885.8 10878.0 10936.8 11187.0 11527.8 11569.6 11164.1 11580.7 11594.5 11702.7 11809.1 7721.2 8485.2 8655.3 8731.2 8787.9 9554.5 9612.5 9648.4 9705.4 9714.0 8382.5 8596.3 8608.1 8702.8 8765.3 8266.8 8349.2 8396.1 8426.5 8471.9 7804.8 7822.4 7928.8 7931.3 7934.4 5675.5 5714.8 5726.2 5747.5 5861.4 5345.7 5409.8 5547.7 5634.0 5648.8 03:59:43 INFO - PROCESS | 15910 | 03:59:43 INFO - PROCESS | 15910 | [#4] prototype.html Cycles:180 Average:4734.24 Median:5377.55 stddev:1392.32 (25.9%) stddev-sans-first:1356.61 03:59:43 INFO - PROCESS | 15910 | Values: 341.0 347.1 353.9 355.3 356.0 5336.3 5478.6 5478.9 5491.2 5494.6 5366.1 5389.0 5424.6 5439.5 5444.3 4092.1 4240.9 4246.7 4271.6 4276.3 4201.5 4207.2 4214.9 4230.8 4242.9 4011.7 4189.5 4215.0 4221.2 4250.3 4092.4 4182.3 4184.7 4190.3 4211.8 3728.7 3755.8 3770.9 3771.7 3786.1 4955.0 5078.2 5176.4 5185.2 5207.6 4488.1 4760.8 4782.4 4793.5 4798.9 5541.0 5569.4 5584.8 5611.6 5634.4 3940.8 4054.9 4075.5 4087.7 4104.6 5772.7 5780.3 5781.7 5788.7 5791.6 4137.4 4154.6 4162.8 4182.2 4186.0 3995.6 4178.4 4236.8 4252.0 4258.5 4684.9 4693.4 4803.9 4816.2 4822.2 5572.5 5575.2 5608.3 5616.6 5629.8 1392.6 1434.4 1435.9 1448.5 1458.2 900.8 906.3 913.9 926.3 931.5 4870.4 4967.0 4990.2 4996.2 4998.9 5136.3 5195.9 5207.5 5212.8 5220.6 5016.2 5336.7 5362.4 5458.8 5514.9 3031.0 3072.8 3074.8 3075.3 3087.0 5877.9 6069.2 6120.7 6142.2 6149.2 5810.5 5842.4 5845.2 5869.7 5882.5 6001.3 6015.7 6045.6 6069.5 6084.5 5638.6 5738.2 5767.8 5773.2 5824.6 5698.0 5730.4 5743.7 5771.3 5772.5 5815.4 6069.8 6113.5 6122.9 6158.4 4107.2 4173.7 4185.7 4186.5 4203.7 5791.7 5805.6 5833.7 5854.6 5879.5 5639.2 5640.7 5691.5 5705.6 5762.3 5666.4 5668.7 5673.3 5694.9 5698.9 5474.5 5635.3 5645.0 5650.8 5650.9 5685.2 5688.9 5748.8 5750.5 5765.2 5361.6 5556.0 5576.9 5581.6 5593.2 03:59:43 INFO - PROCESS | 15910 | 03:59:43 INFO - PROCESS | 15910 | [#5] yui.html Cycles:180 Average:22125.78 Median:3648.51 stddev:32713.38 (896.6%) stddev-sans-first:32765.62 03:59:43 INFO - PROCESS | 15910 | Values: 707.2 739.8 751.1 772.8 817.1 15174.6 16134.8 16472.0 16519.6 17047.7 15047.8 15077.4 15209.4 15213.2 15216.6 724.3 838.8 853.0 858.9 862.2 846.8 851.6 852.1 855.8 856.2 900.6 901.1 901.9 901.9 902.2 757.9 874.5 897.1 897.4 899.9 663.6 664.0 664.3 664.4 664.8 15097.3 15120.8 15123.2 15126.5 15137.6 14549.5 14646.5 14911.0 15248.8 15249.2 13308.7 13355.3 13392.5 13497.3 13511.4 4537.9 4654.1 4656.1 4673.2 4711.5 78336.2 78510.0 78529.6 78617.6 78928.0 11227.9 11255.1 11429.8 11439.2 11730.2 18403.0 18472.4 18473.9 18479.2 18486.4 8459.4 8663.4 8814.6 8921.8 8979.1 4661.6 4724.8 4747.3 4820.1 4821.8 3507.9 3635.9 3642.5 3648.5 3648.5 538.9 639.8 646.3 661.7 671.5 755.8 756.7 757.4 759.5 775.2 10794.8 10808.8 10888.7 10983.6 11147.2 641.0 737.8 745.4 747.8 756.9 4997.2 5116.2 5121.2 5204.6 5224.8 123237.0 126768.0 127508.0 134022.3 134252.3 105116.5 108582.5 109666.5 109731.5 110919.0 91917.0 97925.0 97941.0 98429.5 98858.0 9825.6 9913.8 9969.8 10025.0 10060.9 56232.2 56809.0 56822.4 58137.0 58262.0 65968.7 67484.3 67559.0 77484.0 82419.6 13900.3 14117.3 14210.6 14267.0 14393.2 15057.8 15299.5 15467.9 15592.6 15902.0 10487.8 10704.6 10715.2 11314.0 13967.3 14428.7 14769.4 14794.5 15190.3 15513.3 14866.8 14909.3 15164.5 15283.0 15308.1 11011.6 11192.8 11436.3 11688.8 11762.6 11224.6 11357.2 11487.7 11568.0 11578.6 03:59:43 INFO - PROCESS | 15910 | -------- Summary: end -------- 03:59:43 INFO - PROCESS | 15910 | 03:59:44 INFO - TEST-INFO | 15910: exit 0 03:59:44 INFO - TEST-OK | dromaeo_css | took 1112487ms 03:59:44 INFO - TEST-START | kraken 03:59:44 INFO - operating with platform_type : linux_ 03:59:44 INFO - Initialising browser for kraken test... 03:59:44 INFO - TEST-INFO | started process 16095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHObAJD/profile http://localhost:60820/getInfo.html) 03:59:48 INFO - PROCESS | 16095 | __metrics Screen width/height:1600/1200 03:59:48 INFO - PROCESS | 16095 | colorDepth:24 03:59:48 INFO - PROCESS | 16095 | Browser inner width/height: 1024/697 03:59:48 INFO - PROCESS | 16095 | __metrics 03:59:49 INFO - PROCESS | 16095 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:59:49 ERROR - PROCESS | 16095 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:59:50 INFO - TEST-INFO | 16095: exit 0 03:59:50 INFO - Browser initialized. 03:59:50 INFO - Running cycle 1/1 for kraken test... 03:59:50 INFO - TEST-INFO | started process 16186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHObAJD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:01 INFO - PROCESS | 16186 | RSS: Main: 142131200 04:00:01 INFO - PROCESS | 16186 | 04:00:04 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60820/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:05 INFO - PROCESS | 16186 | RSS: Main: 192778240 04:00:05 INFO - PROCESS | 16186 | 04:00:07 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60820/tests/kraken/driver.html?testName=audio-dft) 04:00:08 INFO - PROCESS | 16186 | RSS: Main: 192901120 04:00:08 INFO - PROCESS | 16186 | 04:00:11 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60820/tests/kraken/driver.html?testName=audio-fft) 04:00:11 INFO - PROCESS | 16186 | RSS: Main: 277676032 04:00:11 INFO - PROCESS | 16186 | 04:00:13 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60820/tests/kraken/driver.html?testName=audio-oscillator) 04:00:14 INFO - PROCESS | 16186 | RSS: Main: 186167296 04:00:14 INFO - PROCESS | 16186 | 04:00:16 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60820/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:17 INFO - PROCESS | 16186 | RSS: Main: 187228160 04:00:17 INFO - PROCESS | 16186 | 04:00:20 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60820/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:20 INFO - PROCESS | 16186 | RSS: Main: 222375936 04:00:20 INFO - PROCESS | 16186 | 04:00:24 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60820/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:24 INFO - PROCESS | 16186 | RSS: Main: 222560256 04:00:24 INFO - PROCESS | 16186 | 04:00:27 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60820/tests/kraken/driver.html?testName=json-parse-financial) 04:00:28 INFO - PROCESS | 16186 | RSS: Main: 221343744 04:00:28 INFO - PROCESS | 16186 | 04:00:29 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60820/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:30 INFO - PROCESS | 16186 | RSS: Main: 198668288 04:00:30 INFO - PROCESS | 16186 | 04:00:31 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60820/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:00:32 INFO - PROCESS | 16186 | RSS: Main: 203022336 04:00:32 INFO - PROCESS | 16186 | 04:00:34 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60820/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:35 INFO - PROCESS | 16186 | RSS: Main: 211578880 04:00:35 INFO - PROCESS | 16186 | 04:00:37 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:38 INFO - PROCESS | 16186 | RSS: Main: 212602880 04:00:38 INFO - PROCESS | 16186 | 04:00:40 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:41 INFO - PROCESS | 16186 | RSS: Main: 212770816 04:00:41 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:60820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60820/tests/kraken/driver.html?testName=ai-astar) 04:00:43 INFO - PROCESS | 16186 | RSS: Main: 255844352 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | __start_tp_report 04:00:43 INFO - PROCESS | 16186 | _x_x_mozilla_page_load 04:00:43 INFO - PROCESS | 16186 | _x_x_mozilla_page_load_details 04:00:43 INFO - PROCESS | 16186 | |i|pagename|runs| 04:00:43 INFO - PROCESS | 16186 | |0;ai-astar;110;105;108;109;110;112;111;111;110;111 04:00:43 INFO - PROCESS | 16186 | |1;audio-beat-detection;154;124;125;169;125;123;154;123;174;123 04:00:43 INFO - PROCESS | 16186 | |2;audio-dft;160;163;160;160;161;159;161;159;161;161 04:00:43 INFO - PROCESS | 16186 | |3;audio-fft;74;76;75;106;75;76;75;74;116;75 04:00:43 INFO - PROCESS | 16186 | |4;audio-oscillator;84;83;113;84;89;84;115;83;85;127 04:00:43 INFO - PROCESS | 16186 | |5;imaging-gaussian-blur;116;117;116;116;116;116;116;117;117;117 04:00:43 INFO - PROCESS | 16186 | |6;imaging-darkroom;146;146;146;145;145;145;145;146;145;145 04:00:43 INFO - PROCESS | 16186 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;94;95 04:00:43 INFO - PROCESS | 16186 | |8;json-parse-financial;51;52;51;52;53;52;52;52;52;52 04:00:43 INFO - PROCESS | 16186 | |9;json-stringify-tinderbox;59;60;61;59;59;60;61;61;60;60 04:00:43 INFO - PROCESS | 16186 | |10;stanford-crypto-aes;75;76;84;78;75;77;78;82;110;79 04:00:43 INFO - PROCESS | 16186 | |11;stanford-crypto-ccm;118;124;126;125;120;117;116;122;119;118 04:00:43 INFO - PROCESS | 16186 | |12;stanford-crypto-pbkdf2;154;153;150;153;150;149;154;151;150;151 04:00:43 INFO - PROCESS | 16186 | |13;stanford-crypto-sha256-iterative;62;61;62;63;61;60;62;61;60;60 04:00:43 INFO - PROCESS | 16186 | __end_tp_report 04:00:43 INFO - PROCESS | 16186 | __start_cc_report 04:00:43 INFO - PROCESS | 16186 | _x_x_mozilla_cycle_collect,1579 04:00:43 INFO - PROCESS | 16186 | __end_cc_report 04:00:43 INFO - PROCESS | 16186 | __startTimestamp1470049243427__endTimestamp 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | ------- Summary: start ------- 04:00:43 INFO - PROCESS | 16186 | Number of tests: 14 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.00 (1.8%) stddev-sans-first:2.12 04:00:43 INFO - PROCESS | 16186 | Values: 110.0 105.0 108.0 109.0 110.0 112.0 111.0 111.0 110.0 111.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:139.50 stddev:20.97 (15.0%) stddev-sans-first:21.57 04:00:43 INFO - PROCESS | 16186 | Values: 154.0 124.0 125.0 169.0 125.0 123.0 154.0 123.0 174.0 123.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 04:00:43 INFO - PROCESS | 16186 | Values: 160.0 163.0 160.0 160.0 161.0 159.0 161.0 159.0 161.0 161.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:15.38 (20.5%) stddev-sans-first:16.02 04:00:43 INFO - PROCESS | 16186 | Values: 74.0 76.0 75.0 106.0 75.0 76.0 75.0 74.0 116.0 75.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:84.00 stddev:16.78 (20.0%) stddev-sans-first:17.35 04:00:43 INFO - PROCESS | 16186 | Values: 84.0 83.0 113.0 84.0 89.0 84.0 115.0 83.0 85.0 127.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:00:43 INFO - PROCESS | 16186 | Values: 116.0 117.0 116.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:00:43 INFO - PROCESS | 16186 | Values: 146.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:00:43 INFO - PROCESS | 16186 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 04:00:43 INFO - PROCESS | 16186 | Values: 51.0 52.0 51.0 52.0 53.0 52.0 52.0 52.0 52.0 52.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 04:00:43 INFO - PROCESS | 16186 | Values: 59.0 60.0 61.0 59.0 59.0 60.0 61.0 61.0 60.0 60.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:78.00 stddev:10.46 (13.4%) stddev-sans-first:10.83 04:00:43 INFO - PROCESS | 16186 | Values: 75.0 76.0 84.0 78.0 75.0 77.0 78.0 82.0 110.0 79.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:121.00 stddev:3.54 (2.9%) stddev-sans-first:3.63 04:00:43 INFO - PROCESS | 16186 | Values: 118.0 124.0 126.0 125.0 120.0 117.0 116.0 122.0 119.0 118.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.50 Median:152.00 stddev:1.84 (1.2%) stddev-sans-first:1.72 04:00:43 INFO - PROCESS | 16186 | Values: 154.0 153.0 150.0 153.0 150.0 149.0 154.0 151.0 150.0 151.0 04:00:43 INFO - PROCESS | 16186 | 04:00:43 INFO - PROCESS | 16186 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.50 stddev:1.03 (1.7%) stddev-sans-first:1.05 04:00:43 INFO - PROCESS | 16186 | Values: 62.0 61.0 62.0 63.0 61.0 60.0 62.0 61.0 60.0 60.0 04:00:43 INFO - PROCESS | 16186 | -------- Summary: end -------- 04:00:43 INFO - PROCESS | 16186 | 04:00:44 INFO - TEST-INFO | 16186: exit 0 04:00:44 INFO - TEST-OK | kraken | took 60080ms 04:00:44 INFO - SUITE-END | took 1172s 04:00:44 INFO - Completed test suite (00:19:32) 04:00:44 INFO - javascript benchmark 04:00:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3380.9492857607133, 3394.9490757638623, 3405.659434056593, 3409.676080772326, 3433.811140387281, 5561.5828812839045, 5584.609077364581, 5601.6358936669085, 5608.158776183574, 5624.128260119678, 5496.725163741807, 5555.8888822223635, 5561.610687251884, 5569.081101618228, 5597.608167428281, 4953.900921981558, 4963.478834722357, 5030.572401345881, 5047.394312682483, 5095.6178286628465, 4993.5755460785695, 4994.525520075587, 5011.624128190382, 5022.522860328263, 5086.898262034757, 5118.181091025437, 5123.129068058421, 5131.923021154686, 5133.614978876599, 5160.483951604847, 5124.92312615311, 5125.154349532323, 5128.4102328232175, 5135.691858488465, 5167.250748641426, 4912.70523768575, 4923.483034281385, 4973.403191616993, 5024.723640199788, 5040.042391945555, 5296.25852380667, 5331.147016477384, 5372.462753724635, 5377.489138531833, 5384.703841288728, 5901.645901245939, 5908.438698323653, 5948.078047902582, 5954.761809527614, 5965.4332838380715, 5677.148427735831, 5746.080627099644, 5759.798407055733, 5895.0, 5911.940880591182, 5471.835844924619, 5486.361502581881, 5520.944790552083, 5546.889062218814, 5574.219609254748, 6056.424639659225, 6070.3929607038945, 6072.544559158081, 6073.331933487313, 6084.5436592255755, 5604.523615492729, 5759.65442073477, 5835.35811060783, 5842.357340692605, 5915.201447804578, 5922.378150294243, 5955.821325360246, 5965.313988891333, 6006.669633170218, 6008.849778755566, 5749.913751293734, 5916.763329466773, 5927.525797936241, 5939.732712027969, 5942.524598032147, 5818.359980402152, 5862.912056319158, 5883.323417807007, 5901.232839730807, 5920.052791553417, 4550.47669518003, 4550.817967281272, 4552.931706024346, 4555.931661025087, 4584.33527138563, 3966.1671049080014, 4005.539362973237, 4086.734362266443, 4094.4472496213225, 4120.340745480708, 5708.372079071299, 5738.139279108167, 5755.884882302331, 5762.855928601734, 5795.507381872504, 5950.702464876826, 5952.255968003999, 5959.910601340984, 6015.0676645120075, 6019.398060193946, 5526.198701188305, 5660.179274005329, 5670.688112153789, 5726.685032323262, 5741.25363702716, 5121.027004869063, 5124.718140502234, 5124.8206312778875, 5126.15418455958, 5146.047981123429, 6200.3799620037635, 6247.718852651642, 6249.25008998923, 6250.0, 6263.154474145932, 5731.054376027909, 5898.174255604133, 5964.284285885721, 5967.49276311501, 5980.3421623622235, 6273.749050037947, 6301.842453938688, 6302.968485157545, 6311.873762524816, 6327.746890124344, 5847.093700476433, 5891.793787217427, 5911.704414779329, 5913.497352724895, 5939.4357536034, 5897.64614123154, 5899.0, 5937.871804357158, 5971.164037034731, 6019.127226552037, 5888.116782482662, 5893.263342082239, 5893.882122357443, 5895.793647222326, 5897.292324921037, 5676.035074037506, 5804.854878628068, 5854.648721076749, 5866.384029676993, 5866.6480011199465, 5578.442155784389, 5590.692511911721, 5593.804216852391, 5616.045272303636, 5622.746976385991, 5769.538436924952, 5779.0, 5780.277465316835, 5823.912641310469, 5834.795782147605, 5577.972110139423, 5582.441755824385, 5661.037623604079, 5667.5465962722055, 5698.686572238566], "value": 5483.330247979191, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.0822724776596, 640.1358166475256, 645.5190882792319, 655.2104713819848, 658.8682263547289, 32080.67919320806, 44635.77682111593, 45871.54128458715, 45965.310520342224, 46014.0, 48287.0, 48891.0, 48920.51079489204, 48954.0, 49065.75467122659, 8237.0, 9098.13567711068, 9222.170004699576, 10713.625023124192, 10958.945205274002, 10972.561097556088, 11071.501782419811, 11076.944615276952, 11079.113670906348, 11081.944590277037, 11069.50187241576, 11114.444277786119, 11122.165837562176, 11122.443877806118, 11128.109751219923, 8320.875186872201, 10665.946670266638, 10931.945340273327, 10944.3980581068, 11336.943315283454, 10891.183161262858, 10961.12311015117, 10978.780424391467, 10985.450727463674, 10996.835047474295, 43657.56342436567, 43729.0, 43999.340009899875, 44235.33646995298, 44309.11381772379, 3674.4855720199193, 3770.6794922431627, 3797.9240415191543, 3992.960070399288, 4459.439196281275, 33398.666013339796, 34213.14467138317, 34436.655633443595, 36515.452268215995, 36957.07607309812, 4643.233866412038, 4704.788284527204, 4747.786349614275, 4793.3049707792525, 4796.519604663821, 417523.0, 417789.0, 418529.0, 418723.0, 419730.0, 68495.65752171207, 68504.3149568508, 68887.65556172187, 69020.0, 69024.6548767253, 38951.80524097361, 39775.2044959105, 39898.40152397716, 41592.0, 41767.582324176976, 17509.824901751075, 18306.17622207004, 18364.540886477676, 18497.33523982848, 18525.53686157857, 14502.419903203754, 14592.927035364755, 14628.926855365868, 14951.252437378087, 15003.474878379204, 20285.188592456136, 20380.184792608427, 20541.691874621894, 20615.896920515603, 20655.380338589865, 7265.709371625076, 7370.410367170613, 7421.888671669929, 7442.255774422514, 7524.887126692995, 958.4297343080856, 1014.9035841595037, 1074.6990842564094, 1128.90968722502, 1138.834868944015, 33756.32487350288, 34086.659133408844, 34391.312173756385, 34520.654793452246, 34704.479432808526, 1008.5124441448804, 1157.2073129906041, 1167.287954347847, 1194.8386967759416, 1252.2486508095253, 17850.642987140185, 18037.7294340585, 18056.909715451602, 18112.909435453003, 18296.908515457337, 625649.0, 630098.0, 630982.0, 631498.0, 631521.0, 64846.35153648497, 64884.67557662181, 65574.34425655683, 65649.34350656527, 65753.04111315003, 1369.486442584031, 1423.9145651261165, 1431.291510702209, 1440.6038339456734, 1461.6126726417508, 31740.0, 34487.137821554665, 34671.30657386889, 34787.652123479456, 34813.82593087119, 52851.471485286194, 54055.72972135114, 54109.0, 54179.72910135424, 54197.45802541924, 449674.0, 459467.0, 460236.0, 460289.0, 461834.0, 27030.864845675645, 29548.704512954595, 29789.851050744608, 30126.698733013265, 30307.242318942204, 51111.0, 51692.74153629358, 52202.73898630482, 53554.0, 55295.44704552903, 44195.0, 44521.33218001798, 44669.77665111654, 45213.77393113145, 45463.0, 44372.77813610911, 44854.3271850916, 45197.09337049546, 45771.31343029791, 45909.31136033029, 44582.777086114365, 45185.548144519445, 45621.0, 45786.77106614579, 45919.0, 37354.8132259337, 38192.0, 38265.80867095647, 39110.217795644494, 39330.2133957325, 30062.54906176453, 30138.69861301359, 30198.245043874078, 30207.69792302049, 30310.0], "value": 21808.348016498145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.89427643089226, 427.82459191731385, 430.09250481484065, 430.21056361576507, 441.5165393893685, 18780.90609546952, 19451.513712157204, 20107.899460502715, 20265.797342026577, 20285.797142028612, 19657.901710491427, 20026.59946801063, 20136.0, 20355.185792568318, 20454.488637784063, 5591.4688104629995, 5775.624584402021, 5819.214406055192, 5820.068788993762, 5823.039198532237, 4089.591040895916, 4104.384342348641, 5724.742386592592, 5776.653400795944, 6123.846903827418, 6359.046143078552, 6416.3262857400005, 6460.224773027243, 6465.062565927938, 6467.126937863375, 6332.588381755218, 6366.522510811685, 6438.45273151778, 6438.806835794933, 6444.774432894873, 3829.5021647185968, 5343.946560534423, 5706.087026075849, 5847.619904706181, 5861.882762344771, 23672.881635591883, 23914.521709565885, 23942.042318307245, 24080.759192408026, 24161.275161745, 2454.361865914875, 2974.1672331746927, 3061.4642437573557, 3128.405602935458, 3189.04328701391, 13924.37340319688, 14485.565433037025, 14493.565193044225, 14813.629659258497, 15243.695126097527, 1981.0589969764392, 2092.309537852505, 2129.744430668314, 2150.731158605174, 2163.1131236193087, 64241.15806566602, 90656.09343906608, 90803.54598227033, 91075.54462227713, 91823.0, 11389.658310250707, 11398.601048963246, 11544.76910461786, 11756.70608234801, 12077.698057548632, 16697.0, 16739.0, 16836.24236909342, 16839.831601684073, 16841.747373789403, 8355.0, 8671.696490622799, 8825.779355516164, 8845.867311990325, 8948.910510894808, 8622.137786221328, 8682.913170868336, 8719.60761765722, 8761.167689069529, 8866.822663546693, 4859.2954021666665, 4917.065757506062, 4951.603871690256, 4962.082014827269, 5144.511271429208, 2049.6413127702594, 2072.367927782041, 2091.5607722378168, 2110.6939493773625, 2111.1766411099684, 930.5114814722325, 1018.7453136715822, 1036.1194432105704, 1076.2091204499632, 1133.8582677165355, 19647.312344068174, 19791.505212369804, 20013.0, 20035.39893803188, 20212.393628191177, 1021.1626466297565, 1031.4636389077637, 1062.9946850265699, 1076.3864597179688, 1092.5520536579963, 10740.946295268473, 10941.0, 11019.779604407868, 11141.442927853575, 11306.830397544043, 522065.0, 532468.0, 535483.0, 551352.0, 551799.0, 93883.0, 95249.0, 98018.50990745143, 98157.0, 98298.0, 1045.5765415006933, 1069.1927594665976, 1075.2526993739432, 1080.8432777247413, 1088.9618863339745, 17104.230309636347, 17139.400120996204, 17462.0, 17465.650686986442, 17624.55938601494, 38922.6107738919, 39838.402423964246, 39987.200255995296, 41219.58780412158, 43626.0, 56237.43762562322, 58077.709611451675, 62958.0, 64008.3599164021, 65967.67016164889, 7987.361011119213, 8035.758927232192, 8330.666773329, 8356.665733370597, 8994.955025224832, 9942.850857237292, 13339.86660133425, 13420.0, 13551.119177253448, 13564.525241616891, 11503.712407189887, 11687.824682629938, 11744.58893938708, 11787.941060294643, 11856.76286474283, 6102.0541816018585, 10853.480512728382, 11548.538058477567, 11646.95177434035, 11665.183437159318, 12056.872227329086, 12207.328596927255, 12243.20419172751, 12256.754864902474, 12279.938600306941, 8118.675252989814, 8280.627371768405, 8340.0, 8340.87488687658, 8515.616797244264, 9185.77035574116, 11261.155413343868, 12287.44706488228, 12292.569760058355, 12406.565770198], "value": 9658.305084201378, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.282795774155, 1582.050769538277, 1626.4957863062452, 1821.408042386224, 1949.4541528372051, 8994.820103597924, 9329.300302477308, 9338.859917101241, 9349.439033657985, 9553.092456216647, 9163.95418022909, 9427.95286023569, 9614.95192524038, 9624.80750384992, 9634.373765705242, 2111.5671287386126, 2480.417101981033, 2486.2292689266296, 2535.911243106492, 2552.52778236026, 2501.687289088864, 2513.7234904160528, 2522.230719630512, 2523.8864251108744, 2525.9242222733346, 2474.9010039598393, 2487.6517287579754, 2488.950220995579, 2491.501699660066, 2492.7881130103965, 2137.091736012196, 2421.225207933462, 2485.6644353012293, 2490.713567939692, 2502.78726308264, 2458.0659349447274, 2475.10896077412, 2483.4412257242157, 2526.4315529005826, 2528.266802627236, 9441.858372124423, 9447.149756521945, 9450.19673327768, 9482.762930926712, 9502.0, 5657.32112146545, 5795.217645617872, 5797.304323481209, 5802.390748971339, 5802.651840889518, 3603.369410353204, 3613.9277214455565, 3698.389765688658, 3732.2908647357185, 3748.212875296191, 1296.274086511547, 1304.3543445994198, 1322.7883538633869, 1328.2296268164441, 1353.147517064253, 13661.18032918028, 13901.165930044128, 13919.164850108924, 13978.720425591431, 13987.580372588838, 5135.075686376414, 5140.203268493389, 5192.0, 5199.064168449715, 5207.661502002357, 11711.004564612103, 11732.0, 11740.295582265091, 11774.88225117755, 11778.88221117795, 5015.799368025238, 5829.5044921181325, 5836.795712150054, 5843.298804143445, 5844.912326315109, 5142.794288228429, 5266.420693723688, 5271.051210782096, 5302.602304827076, 5305.442928492453, 4415.602595766396, 4428.446444194476, 4454.821807127743, 4494.0337827367275, 4504.6396288296855, 1350.216874212954, 1380.8688174623394, 1384.4669802126052, 1394.6861956059806, 1411.2520364206987, 894.7807787092204, 938.4275591888942, 991.2268430624125, 1051.894810518942, 1071.6570697376922, 6363.427291543783, 6378.521610879203, 6539.280679125292, 6571.507136964651, 6610.570312929644, 504.4955044955045, 505.0958783776998, 505.858359659296, 1087.8694556653252, 1104.1718710966775, 4387.802548885308, 4439.378487011821, 4439.4006809080365, 4493.1013797240685, 4502.414686090853, 12055.336956467478, 12428.875711242952, 12431.813522797165, 12438.937805310916, 12478.376081195904, 11723.589674361356, 12049.578264760692, 12127.393630318626, 12306.323152226714, 12460.065495087905, 8891.510966896753, 8982.371234013557, 9003.594838232295, 9019.098090190928, 9030.86453703195, 6467.935320646921, 6583.63789991555, 6724.747349031673, 6834.760783372558, 6885.758998435031, 10878.0, 10936.781264374828, 11187.0, 11527.769444610893, 11569.595064172714, 11164.106871450102, 11580.710482238012, 11594.47824847867, 11702.70743231392, 11809.05527557776, 7721.150673425806, 8485.151484851465, 8655.307575393828, 8731.170538798804, 8787.91212087871, 9554.474503902075, 9612.51937403113, 9648.421094734058, 9705.417674939526, 9714.0, 8382.533056714929, 8596.269317108116, 8608.139186081593, 8702.82594348122, 8765.34259930495, 8266.751997440086, 8349.165083491846, 8396.118407567361, 8426.4944103354, 8471.915280847114, 7804.84390312202, 7822.374210063067, 7928.841423171389, 7931.325837303893, 7934.444588878723, 5675.545956323402, 5714.771409143587, 5726.198332233574, 5747.511461525817, 5861.384554621874, 5345.732713364238, 5409.783608655767, 5547.722613869371, 5634.0422128239115, 5648.830535083954], "value": 5048.542966633831, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.0348713141809, 347.1027394186029, 353.91682954505694, 355.3284292686821, 356.0, 5336.252924590555, 5478.616496845218, 5478.876830249799, 5491.203775452557, 5494.587905907053, 5366.09503626213, 5389.0, 5424.620276580641, 5439.5104440600335, 5444.292242008533, 4092.0997380576373, 4240.851570195044, 4246.723962942414, 4271.594198551133, 4276.294411422112, 4201.453811004565, 4207.200631879949, 4214.852480163195, 4230.830766769341, 4242.8727138185905, 4011.6761468715254, 4189.518205406372, 4215.0, 4221.176870510251, 4250.341197114437, 4092.4270602115726, 4182.2890108681595, 4184.748915065075, 4190.266703326905, 4211.789410529492, 3728.6830619397383, 3755.7746535207702, 3770.9434358484646, 3771.679407250387, 3786.091338078869, 4954.950450495521, 5078.187490001619, 5176.404713457963, 5185.22221666753, 5207.6354655174155, 4488.079943611585, 4760.785764640565, 4782.426108866924, 4793.496682848286, 4798.928016079762, 5540.972295138539, 5569.359523654791, 5584.804531841366, 5611.579131565108, 5634.352049514277, 3940.783256920868, 4054.945714114322, 4075.49056367954, 4087.693422993287, 4104.630583247522, 5772.7113644317615, 5780.277465316835, 5781.71091445426, 5788.739506722165, 5791.5656325775735, 4137.379393091001, 4154.605312495308, 4162.771047592351, 4182.205380977604, 4185.97907010463, 3995.580464051291, 4178.35235538492, 4236.788160591958, 4251.9787401062795, 4258.508772368137, 4684.882877928079, 4693.389859318335, 4803.855884323476, 4816.15717249487, 4822.180229361017, 5572.5263352614675, 5575.1915972184615, 5608.327000759935, 5616.550675945915, 5629.819152179006, 1392.554382597559, 1434.419060280588, 1435.9445807331604, 1448.4857875454272, 1458.1688437590683, 900.7973206028591, 906.2930913887178, 913.8766266554063, 926.305271046715, 931.4783721116197, 4870.366852309248, 4967.0, 4990.203526730446, 4996.225585034325, 4998.875477921869, 5136.280920671109, 5195.948040519622, 5207.479252074762, 5212.791488340424, 5220.556252718486, 5016.222485514678, 5336.67979921206, 5362.3565172178805, 5458.754356053987, 5514.91727624086, 3030.9848450757604, 3072.75553400873, 3074.8462576871066, 3075.3234288456506, 3087.027586310305, 5877.94346939589, 6069.180660610761, 6120.724567394478, 6142.232220972379, 6149.169862068564, 5810.535157187415, 5842.357340692521, 5845.210896528999, 5869.735861886225, 5882.529397648178, 6001.339852616209, 6015.699215039231, 6045.6070355426755, 6069.453749162597, 6084.4828189603495, 5638.562166647479, 5738.196652468741, 5767.798127065533, 5773.1814478439155, 5824.621399609012, 5697.971510142423, 5730.426957304237, 5743.736377996834, 5771.307443106686, 5772.5381969441505, 5815.360310365941, 6069.757209711739, 6113.5414843886, 6122.908156377569, 6158.445739883432, 4107.178564287215, 4173.749575025508, 4185.727927684691, 4186.455760751083, 4203.726757760735, 5791.710414479175, 5805.564582656233, 5833.708314584339, 5854.560907931837, 5879.529637629065, 5639.238702775073, 5640.717964101696, 5691.516221121251, 5705.630648644213, 5762.30852297727, 5666.401834834992, 5668.744906479301, 5673.319201695823, 5694.943050569607, 5698.886022279614, 5474.534664553557, 5635.267415236157, 5645.012122878562, 5650.830475085754, 5650.915236271541, 5685.175649530877, 5688.890666320193, 5748.770049197985, 5750.539956803362, 5765.155150352015, 5361.597880158925, 5555.972220138873, 5576.91634625489, 5581.581381396492, 5593.244911936999], "value": 4291.750543417758, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.1620130145777, 739.8002539314385, 751.1249394455459, 772.8222508822971, 817.1460823439508, 15174.62063448413, 16134.757978630301, 16471.999999999985, 16519.587010324747, 17047.744283835753, 15047.849521504782, 15077.396904123849, 15209.391624335041, 15213.163276019815, 15216.619584510392, 724.3480867219492, 838.8406202821475, 853.0488505316574, 858.9441686290403, 862.2455351567379, 846.7756044648173, 851.586980314547, 852.075498084579, 855.7946092937713, 856.1994535109692, 900.6442455230213, 901.0808974845653, 901.8737376767258, 901.9233365163936, 902.2240872849344, 757.8711619024779, 874.4971641306242, 897.0894542039835, 897.4121950122681, 899.8875140607424, 663.5653646861314, 663.9535232533725, 664.3024823934849, 664.4186336955164, 664.8204984654164, 15097.3206205721, 15120.773188402183, 15123.168225747579, 15126.546203613909, 15137.621559460991, 14549.490767823181, 14646.487372942003, 14911.0, 15248.771268430983, 15249.161296128708, 13308.667283317898, 13355.265460399674, 13392.531261405902, 13497.2576508292, 13511.391987360494, 4537.886552836172, 4654.0924519718665, 4656.138614356321, 4673.182193116191, 4711.528847115295, 78336.21663783403, 78509.99999999943, 78529.60735196345, 78617.60691196565, 78928.0, 11227.943860280646, 11255.099592032619, 11429.771404571862, 11439.199256052163, 11730.178887477794, 18403.0, 18472.353467628836, 18473.907630462032, 18479.168437420347, 18486.445406637824, 8459.407841451162, 8663.436876603, 8814.603342849587, 8921.776955576162, 8979.057198994142, 4661.627069834405, 4724.771559394513, 4747.311639812277, 4820.108279968217, 4821.783019764049, 3507.8947631571095, 3635.8727444539313, 3642.5446819147605, 3648.4709717090873, 3648.543932008499, 538.9110796718576, 639.8144538083903, 646.2697152217963, 661.6625520984236, 671.4997326991422, 755.8412733326063, 756.670848181043, 757.3638143958991, 759.4987308376556, 775.158952536493, 10794.838077428845, 10808.78382432347, 10888.67333979982, 10983.560657573767, 11147.21969462146, 641.0, 737.8118579762127, 745.3627148787817, 747.8055705516605, 756.9280918312752, 4997.150484417658, 5116.155834287375, 5121.155009423478, 5204.635675502678, 5224.843254702365, 123237.0, 126768.0, 127508.0, 134022.32988835187, 134252.3287383557, 105116.47441762743, 108582.45708771405, 109666.45166774275, 109731.45134274277, 110919.0, 91917.0, 97925.0, 97941.02058979461, 98429.50785246027, 98858.0, 9825.557849896915, 9913.801723965624, 9969.750756231153, 10025.0, 10060.899391005996, 56232.156517653086, 56809.0, 56822.43177568171, 58137.0, 58262.0, 65968.68062638624, 67484.32515674976, 67559.0, 77484.0, 82419.5879020625, 13900.304984750925, 14117.2941352934, 14210.644733881736, 14267.0, 14393.208373539555, 15057.774133388228, 15299.541013769605, 15467.922660386626, 15592.636067814527, 15902.0, 10487.790244195226, 10704.625338113128, 10715.196360272856, 11314.0, 13967.301634918416, 14428.711425771637, 14769.409223630935, 14794.482193123189, 15190.316435760196, 15513.301901414688, 14866.776998344818, 14909.25453727331, 15164.545063648107, 15283.0, 15308.081515109128, 11011.61459348951, 11192.83210751823, 11436.256643318158, 11688.824667629822, 11762.647120586396, 11224.576504166307, 11357.204995650225, 11487.712807179887, 11568.0, 11578.594749183738], "value": 7889.227246539933, "unit": "score"}], "name": "dromaeo_css", "value": 7630.8805894787165, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 108.0, 109.0, 110.0, 112.0, 111.0, 111.0, 110.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 125.0, 169.0, 125.0, 123.0, 154.0, 123.0, 174.0, 123.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 160.0, 161.0, 159.0, 161.0, 159.0, 161.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 106.0, 75.0, 76.0, 75.0, 74.0, 116.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 113.0, 84.0, 89.0, 84.0, 115.0, 83.0, 85.0, 127.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 51.0, 52.0, 53.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 61.0, 59.0, 59.0, 60.0, 61.0, 61.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 84.0, 78.0, 75.0, 77.0, 78.0, 82.0, 110.0, 79.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 124.0, 126.0, 125.0, 120.0, 117.0, 116.0, 122.0, 119.0, 118.0], "value": 120.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 150.0, 153.0, 150.0, 149.0, 154.0, 151.0, 150.0, 151.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 63.0, 61.0, 60.0, 62.0, 61.0, 60.0, 60.0], "value": 61.2, "unit": "score"}], "name": "kraken", "value": 1469.6000000000001, "alertThreshold": 2.0}]} 04:00:44 INFO - Return code: 0 04:00:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:00:44 ERROR - # TBPL SUCCESS # 04:00:44 INFO - Running post-action listener: _resource_record_post_action 04:00:44 INFO - ##### 04:00:44 INFO - ##### Finished run-tests step (success) 04:00:44 INFO - ##### 04:00:44 INFO - Running post-run listener: _resource_record_post_run 04:00:44 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 500101120; Read time: 0; Write time: 427332 04:00:44 INFO - TinderboxPrint: CPU usage
13.1% 04:00:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:00:44 INFO - TinderboxPrint: I/O write bytes / time
500,101,120 / 427,332 04:00:44 INFO - TinderboxPrint: CPU idle
8,248.3 (86.9%) 04:00:44 INFO - TinderboxPrint: CPU user
1,196.3 (12.6%) 04:00:44 INFO - TinderboxPrint: Swap in / out
0 / 0 04:00:44 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249683968; Read time: 0; Write time: 268916 04:00:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 250417152; Read time: 0; Write time: 158416 04:00:45 INFO - Running post-run listener: _upload_blobber_files 04:00:45 INFO - Blob upload gear active. 04:00:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:45 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 04:00:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:00:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:00:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:00:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:00:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:46 INFO - (blobuploader) - INFO - Done attempting. 04:00:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:00:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:00:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:47 INFO - (blobuploader) - INFO - Done attempting. 04:00:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:00:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:50 INFO - (blobuploader) - INFO - Done attempting. 04:00:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:50 INFO - Return code: 0 04:00:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4e9664861c0a1258447764d2685032c68c55411b951e24b34fd6c70c5d1a335060eccc5ba7881656edf51336dd7ba15d1c75132b3c5c962e7271ddf18052424", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2d7079d38897f5b6d8630d78a60c8e0ad1c05127c9792899f648a806aec8d70e0c7bcfcec4910c8de4bf78d13127fda937ee87d7f821cafc314fbf80d533b09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7cd0b52c96736235b8d001fbf38a1389a8a13aa797cae466c2a8566a6ce77c09b73af0a8cf1e5e87a1039d9fd743994f698c7b4263c763cf3f4739abe4abf3b"} 04:00:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:50 INFO - Contents: 04:00:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4e9664861c0a1258447764d2685032c68c55411b951e24b34fd6c70c5d1a335060eccc5ba7881656edf51336dd7ba15d1c75132b3c5c962e7271ddf18052424", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2d7079d38897f5b6d8630d78a60c8e0ad1c05127c9792899f648a806aec8d70e0c7bcfcec4910c8de4bf78d13127fda937ee87d7f821cafc314fbf80d533b09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7cd0b52c96736235b8d001fbf38a1389a8a13aa797cae466c2a8566a6ce77c09b73af0a8cf1e5e87a1039d9fd743994f698c7b4263c763cf3f4739abe4abf3b"} 04:00:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:50 INFO - Copying logs to upload dir... 04:00:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.578245 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-01 04:00:50.469283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 04:00:50.472690) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4e9664861c0a1258447764d2685032c68c55411b951e24b34fd6c70c5d1a335060eccc5ba7881656edf51336dd7ba15d1c75132b3c5c962e7271ddf18052424", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2d7079d38897f5b6d8630d78a60c8e0ad1c05127c9792899f648a806aec8d70e0c7bcfcec4910c8de4bf78d13127fda937ee87d7f821cafc314fbf80d533b09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7cd0b52c96736235b8d001fbf38a1389a8a13aa797cae466c2a8566a6ce77c09b73af0a8cf1e5e87a1039d9fd743994f698c7b4263c763cf3f4739abe4abf3b"} build_url:https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4e9664861c0a1258447764d2685032c68c55411b951e24b34fd6c70c5d1a335060eccc5ba7881656edf51336dd7ba15d1c75132b3c5c962e7271ddf18052424", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2d7079d38897f5b6d8630d78a60c8e0ad1c05127c9792899f648a806aec8d70e0c7bcfcec4910c8de4bf78d13127fda937ee87d7f821cafc314fbf80d533b09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7cd0b52c96736235b8d001fbf38a1389a8a13aa797cae466c2a8566a6ce77c09b73af0a8cf1e5e87a1039d9fd743994f698c7b4263c763cf3f4739abe4abf3b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 04:00:50.500882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 04:00:50.501217) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1470047613.877154-1465445247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 04:00:50.583361) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 04:00:50.583772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 04:00:50.584095) ========= ========= Total master_lag: 0.17 =========