builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1465291702.58 results: success (0) buildid: 20160606202128 builduid: 7ec3cba5ae654a229f94a8ace0e91e74 revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:22.585071) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:22.585976) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:22.586423) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:22.602804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:22.603119) ========= 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=db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 02:28:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-06-07 02:28:22 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096107 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:22.717583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:22.718514) ========= 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=db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016573 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:22.771786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 02:28:22.772670) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e70892847544db94d801f80543fe8a7f6d836f90 --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 e70892847544db94d801f80543fe8a7f6d836f90 --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=db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 02:28:22,971 truncating revision to first 12 chars 2016-06-07 02:28:22,972 Setting DEBUG logging. 2016-06-07 02:28:22,972 attempt 1/10 2016-06-07 02:28:22,972 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e70892847544?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 02:28:23,837 unpacking tar archive at: mozilla-aurora-e70892847544/testing/mozharness/ program finished with exit code 0 elapsedTime=1.200962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 02:28:23.993332) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:23.994221) ========= script_repo_revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:23.995251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:23.995982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:24.008945) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2016-06-07 02:28:24.009471) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:28:24 INFO - MultiFileLogger online at 20160607 02:28:24 in /builds/slave/test 02:28:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:28:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:28:24 INFO - {'append_to_log': False, 02:28:24 INFO - 'base_work_dir': '/builds/slave/test', 02:28:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:28:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:28:24 INFO - 'branch': 'Mozilla-Aurora', 02:28:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:28:24 INFO - 'config_files': ('talos/linux_config.py',), 02:28:24 INFO - 'default_actions': ('clobber', 02:28:24 INFO - 'read-buildbot-config', 02:28:24 INFO - 'download-and-extract', 02:28:24 INFO - 'populate-webroot', 02:28:24 INFO - 'create-virtualenv', 02:28:24 INFO - 'install', 02:28:24 INFO - 'run-tests'), 02:28:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:28:24 INFO - 'download_minidump_stackwalk': True, 02:28:24 INFO - 'download_symbols': 'ondemand', 02:28:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:28:24 INFO - 'tooltool.py': '/tools/tooltool.py', 02:28:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:28:24 INFO - '/tools/misc-python/virtualenv.py')}, 02:28:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:28:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:28:24 INFO - 'installer_path': 'installer.exe', 02:28:24 INFO - 'log_level': 'info', 02:28:24 INFO - 'log_name': 'talos', 02:28:24 INFO - 'log_to_console': True, 02:28:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:28:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:28:24 INFO - 'opt_config_files': (), 02:28:24 INFO - 'pip_index': False, 02:28:24 INFO - 'sps_profile': False, 02:28:24 INFO - 'sps_profile_interval': 0, 02:28:24 INFO - 'suite': 'dromaeojs-e10s', 02:28:24 INFO - 'system_bits': '32', 02:28:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:28:24 INFO - 'title': 'talos-linux64-ix-031', 02:28:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:28:24 INFO - 'use_talos_json': True, 02:28:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:28:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:28:24 INFO - 'work_dir': 'build'} 02:28:24 INFO - ##### 02:28:24 INFO - ##### Running clobber step. 02:28:24 INFO - ##### 02:28:24 INFO - Running pre-action listener: _resource_record_pre_action 02:28:24 INFO - Running main action method: clobber 02:28:24 INFO - rmtree: /builds/slave/test/build 02:28:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:28:25 INFO - Running post-action listener: _resource_record_post_action 02:28:25 INFO - ##### 02:28:25 INFO - ##### Finished clobber step (success) 02:28:25 INFO - ##### 02:28:25 INFO - ##### 02:28:25 INFO - ##### Running read-buildbot-config step. 02:28:25 INFO - ##### 02:28:25 INFO - Running pre-action listener: _resource_record_pre_action 02:28:25 INFO - Running main action method: read_buildbot_config 02:28:25 INFO - Using buildbot properties: 02:28:25 INFO - { 02:28:25 INFO - "project": "", 02:28:25 INFO - "product": "firefox", 02:28:25 INFO - "script_repo_revision": "production", 02:28:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:28:25 INFO - "repository": "", 02:28:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:28:25 INFO - "buildid": "20160606202128", 02:28:25 INFO - "pgo_build": "True", 02:28:25 INFO - "basedir": "/builds/slave/test", 02:28:25 INFO - "buildnumber": 358, 02:28:25 INFO - "slavename": "talos-linux64-ix-031", 02:28:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:28:25 INFO - "platform": "ubuntu64_hw", 02:28:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:28:25 INFO - "branch": "mozilla-aurora", 02:28:25 INFO - "repo_path": "releases/mozilla-aurora", 02:28:25 INFO - "revision": "e70892847544db94d801f80543fe8a7f6d836f90", 02:28:25 INFO - "stage_platform": "linux64-pgo", 02:28:25 INFO - "builduid": "7ec3cba5ae654a229f94a8ace0e91e74", 02:28:25 INFO - "slavebuilddir": "test" 02:28:25 INFO - } 02:28:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 02:28:25 INFO - Running post-action listener: _resource_record_post_action 02:28:25 INFO - ##### 02:28:25 INFO - ##### Finished read-buildbot-config step (success) 02:28:25 INFO - ##### 02:28:25 INFO - ##### 02:28:25 INFO - ##### Running download-and-extract step. 02:28:25 INFO - ##### 02:28:25 INFO - Running pre-action listener: _resource_record_pre_action 02:28:25 INFO - Running main action method: download_and_extract 02:28:25 INFO - mkdir: /builds/slave/test/build/tests 02:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:25 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:28:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:28:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:28:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:26 INFO - Downloaded 1361 bytes. 02:28:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:28:26 INFO - Using the following test package requirements: 02:28:26 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:28:26 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:28:26 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:28:26 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:26 INFO - u'jsshell-linux-x86_64.zip'], 02:28:26 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:28:26 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:28:26 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:28:26 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:28:26 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:28:26 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:28:26 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:26 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:28:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:28:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:28:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:27 INFO - Downloaded 24473779 bytes. 02:28:27 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'] 02:28:27 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 02:28:28 INFO - Return code: 0 02:28:28 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 02:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:28 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:28:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:28:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:28:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:30 INFO - Downloaded 24473779 bytes. 02:28:30 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'] 02:28:30 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 02:28:31 INFO - Return code: 0 02:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:31 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:28:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:28:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:28:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:32 INFO - Downloaded 10833369 bytes. 02:28:32 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'] 02:28:32 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 02:28:33 INFO - Return code: 0 02:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:33 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:28:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:28:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:28:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:34 INFO - Downloaded 63553597 bytes. 02:28:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:28:34 INFO - mkdir: /builds/slave/test/properties 02:28:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:28:34 INFO - Writing to file /builds/slave/test/properties/build_url 02:28:34 INFO - Contents: 02:28:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:28:35 INFO - Running post-action listener: _resource_record_post_action 02:28:35 INFO - Running post-action listener: set_extra_try_arguments 02:28:35 INFO - ##### 02:28:35 INFO - ##### Finished download-and-extract step (success) 02:28:35 INFO - ##### 02:28:35 INFO - ##### 02:28:35 INFO - ##### Running populate-webroot step. 02:28:35 INFO - ##### 02:28:35 INFO - Running pre-action listener: _resource_record_pre_action 02:28:35 INFO - Running main action method: populate_webroot 02:28:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:28:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:28:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:28:35 INFO - '--tppagecycles', 02:28:35 INFO - '7'], 02:28:35 INFO - 'tests': ['tsvgm']}}, 02:28:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:28:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:28:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:28:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:28:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:28:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:28:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:35 INFO - 'talos_options': ['--disable-e10s'], 02:28:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:35 INFO - 'talos_options': ['--disable-e10s'], 02:28:35 INFO - 'tests': ['damp', 'tps']}, 02:28:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:35 INFO - 'tests': ['damp', 'tps']}, 02:28:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:28:35 INFO - 'tests': ['dromaeo_dom']}, 02:28:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:28:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:28:35 INFO - 'tests': ['a11yr', 02:28:35 INFO - 'ts_paint', 02:28:35 INFO - 'tpaint', 02:28:35 INFO - 'sessionrestore', 02:28:35 INFO - 'sessionrestore_no_auto_restore', 02:28:35 INFO - 'tabpaint']}, 02:28:35 INFO - 'other-e10s': {'tests': ['a11yr', 02:28:35 INFO - 'ts_paint', 02:28:35 INFO - 'tpaint', 02:28:35 INFO - 'sessionrestore', 02:28:35 INFO - 'sessionrestore_no_auto_restore', 02:28:35 INFO - 'tabpaint']}, 02:28:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:28:35 INFO - 'ts_paint', 02:28:35 INFO - 'tpaint', 02:28:35 INFO - 'sessionrestore', 02:28:35 INFO - 'sessionrestore_no_auto_restore', 02:28:35 INFO - 'tabpaint']}, 02:28:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:28:35 INFO - 'ts_paint', 02:28:35 INFO - 'tpaint', 02:28:35 INFO - 'sessionrestore', 02:28:35 INFO - 'sessionrestore_no_auto_restore', 02:28:35 INFO - 'tabpaint']}, 02:28:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:28:35 INFO - 'tests': ['a11yr', 02:28:35 INFO - 'ts_paint', 02:28:35 INFO - 'tpaint', 02:28:35 INFO - 'sessionrestore', 02:28:35 INFO - 'sessionrestore_no_auto_restore', 02:28:35 INFO - 'tabpaint']}, 02:28:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:28:35 INFO - 'tests': ['a11yr', 02:28:35 INFO - 'ts_paint', 02:28:35 INFO - 'tpaint', 02:28:35 INFO - 'sessionrestore', 02:28:35 INFO - 'sessionrestore_no_auto_restore', 02:28:35 INFO - 'tabpaint']}, 02:28:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:28:35 INFO - 'tests': ['tsvgx', 02:28:35 INFO - 'tsvgr_opacity', 02:28:35 INFO - 'tart', 02:28:35 INFO - 'tscrollx', 02:28:35 INFO - 'cart']}, 02:28:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:28:35 INFO - 'tsvgr_opacity', 02:28:35 INFO - 'tart', 02:28:35 INFO - 'tscrollx', 02:28:35 INFO - 'cart']}, 02:28:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:35 INFO - 'talos_options': ['--disable-e10s'], 02:28:35 INFO - 'tests': ['tp5o']}, 02:28:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:35 INFO - 'tests': ['tp5o']}, 02:28:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:35 INFO - 'talos_options': ['--disable-e10s', 02:28:35 INFO - '--xperf_path', 02:28:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:35 INFO - 'tests': ['tp5n']}, 02:28:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:35 INFO - 'talos_options': ['--xperf_path', 02:28:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:35 INFO - 'tests': ['tp5n']}}, 02:28:35 INFO - 'talos.zip': {'path': '', 02:28:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:28:35 INFO - Running post-action listener: _resource_record_post_action 02:28:35 INFO - ##### 02:28:35 INFO - ##### Finished populate-webroot step (success) 02:28:35 INFO - ##### 02:28:35 INFO - ##### 02:28:35 INFO - ##### Running create-virtualenv step. 02:28:35 INFO - ##### 02:28:35 INFO - Running pre-action listener: _resource_record_pre_action 02:28:35 INFO - Running main action method: create_virtualenv 02:28:35 INFO - Creating virtualenv /builds/slave/test/build/venv 02:28:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:28:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:28:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:28:35 INFO - Using real prefix '/usr' 02:28:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:28:35 INFO - Installing distribute.............................................................................................................................................................................................done. 02:28:37 INFO - Installing pip.................done. 02:28:37 INFO - Return code: 0 02:28:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:37 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 0x7fbf2ce9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf1c0>, '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 0x15c00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0550>, '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': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:28:37 INFO - Using env: {'DISPLAY': ':0', 02:28:37 INFO - 'HOME': '/home/cltbld', 02:28:37 INFO - 'LANG': 'en_US.UTF-8', 02:28:37 INFO - 'LANGUAGE': 'en_US:en', 02:28:37 INFO - 'LOGNAME': 'cltbld', 02:28:37 INFO - 'MAIL': '/var/mail/cltbld', 02:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:37 INFO - 'MOZ_NO_REMOTE': '1', 02:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:37 INFO - 'NO_EM_RESTART': '1', 02:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:37 INFO - 'PWD': '/builds/slave/test', 02:28:37 INFO - 'SHELL': '/bin/bash', 02:28:37 INFO - 'SHLVL': '1', 02:28:37 INFO - 'TERM': 'linux', 02:28:37 INFO - 'TMOUT': '86400', 02:28:37 INFO - 'USER': 'cltbld', 02:28:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 02:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:37 INFO - '_': '/tools/buildbot/bin/python'} 02:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:28:38 INFO - Cleaning up... 02:28:38 INFO - Return code: 0 02:28:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf2ce9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf1c0>, '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 0x15c00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0550>, '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': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:28:38 INFO - Using env: {'DISPLAY': ':0', 02:28:38 INFO - 'HOME': '/home/cltbld', 02:28:38 INFO - 'LANG': 'en_US.UTF-8', 02:28:38 INFO - 'LANGUAGE': 'en_US:en', 02:28:38 INFO - 'LOGNAME': 'cltbld', 02:28:38 INFO - 'MAIL': '/var/mail/cltbld', 02:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:38 INFO - 'MOZ_NO_REMOTE': '1', 02:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:38 INFO - 'NO_EM_RESTART': '1', 02:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:38 INFO - 'PWD': '/builds/slave/test', 02:28:38 INFO - 'SHELL': '/bin/bash', 02:28:38 INFO - 'SHLVL': '1', 02:28:38 INFO - 'TERM': 'linux', 02:28:38 INFO - 'TMOUT': '86400', 02:28:38 INFO - 'USER': 'cltbld', 02:28:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 02:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:38 INFO - '_': '/tools/buildbot/bin/python'} 02:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:38 INFO - Downloading/unpacking psutil>=3.1.1 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:28:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:40 INFO - Installing collected packages: psutil 02:28:40 INFO - Running setup.py install for psutil 02:28:40 INFO - building 'psutil._psutil_linux' extension 02:28:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:28:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:28:40 INFO - building 'psutil._psutil_posix' extension 02:28:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:28:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:28:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:40 INFO - Successfully installed psutil 02:28:40 INFO - Cleaning up... 02:28:40 INFO - Return code: 0 02:28:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf2ce9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf1c0>, '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 0x15c00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0550>, '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': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:28: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 mozsystemmonitor==0.3 02:28:40 INFO - Using env: {'DISPLAY': ':0', 02:28:40 INFO - 'HOME': '/home/cltbld', 02:28:40 INFO - 'LANG': 'en_US.UTF-8', 02:28:40 INFO - 'LANGUAGE': 'en_US:en', 02:28:40 INFO - 'LOGNAME': 'cltbld', 02:28:40 INFO - 'MAIL': '/var/mail/cltbld', 02:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:40 INFO - 'MOZ_NO_REMOTE': '1', 02:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:40 INFO - 'NO_EM_RESTART': '1', 02:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:40 INFO - 'PWD': '/builds/slave/test', 02:28:40 INFO - 'SHELL': '/bin/bash', 02:28:40 INFO - 'SHLVL': '1', 02:28:40 INFO - 'TERM': 'linux', 02:28:40 INFO - 'TMOUT': '86400', 02:28:40 INFO - 'USER': 'cltbld', 02:28:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 02:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:40 INFO - '_': '/tools/buildbot/bin/python'} 02:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:28:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:28:42 INFO - Installing collected packages: mozsystemmonitor 02:28:42 INFO - Running setup.py install for mozsystemmonitor 02:28:43 INFO - Successfully installed mozsystemmonitor 02:28:43 INFO - Cleaning up... 02:28:43 INFO - Return code: 0 02:28:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:43 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 0x7fbf2ce9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf1c0>, '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 0x15c00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0550>, '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': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:28:43 INFO - Using env: {'DISPLAY': ':0', 02:28:43 INFO - 'HOME': '/home/cltbld', 02:28:43 INFO - 'LANG': 'en_US.UTF-8', 02:28:43 INFO - 'LANGUAGE': 'en_US:en', 02:28:43 INFO - 'LOGNAME': 'cltbld', 02:28:43 INFO - 'MAIL': '/var/mail/cltbld', 02:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:43 INFO - 'MOZ_NO_REMOTE': '1', 02:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:43 INFO - 'NO_EM_RESTART': '1', 02:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:43 INFO - 'PWD': '/builds/slave/test', 02:28:43 INFO - 'SHELL': '/bin/bash', 02:28:43 INFO - 'SHLVL': '1', 02:28:43 INFO - 'TERM': 'linux', 02:28:43 INFO - 'TMOUT': '86400', 02:28:43 INFO - 'USER': 'cltbld', 02:28:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 02:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:43 INFO - '_': '/tools/buildbot/bin/python'} 02:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:43 INFO - Downloading/unpacking jsonschema==2.5.1 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:28:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:45 INFO - Downloading functools32-3.2.3-2.tar.gz 02:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:28:45 INFO - warning: no files found matching '*.txt' 02:28:45 INFO - no previously-included directories found matching 'build' 02:28:45 INFO - no previously-included directories found matching 'dist' 02:28:45 INFO - no previously-included directories found matching '.git*' 02:28:45 INFO - Installing collected packages: jsonschema, functools32 02:28:45 INFO - Running setup.py install for functools32 02:28:45 INFO - warning: no files found matching '*.txt' 02:28:45 INFO - no previously-included directories found matching 'build' 02:28:45 INFO - no previously-included directories found matching 'dist' 02:28:45 INFO - no previously-included directories found matching '.git*' 02:28:45 INFO - Successfully installed jsonschema functools32 02:28:45 INFO - Cleaning up... 02:28:45 INFO - Return code: 0 02:28:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:45 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 0x7fbf2ce9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf1c0>, '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 0x15c00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0550>, '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': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:28:45 INFO - Using env: {'DISPLAY': ':0', 02:28:45 INFO - 'HOME': '/home/cltbld', 02:28:45 INFO - 'LANG': 'en_US.UTF-8', 02:28:45 INFO - 'LANGUAGE': 'en_US:en', 02:28:45 INFO - 'LOGNAME': 'cltbld', 02:28:45 INFO - 'MAIL': '/var/mail/cltbld', 02:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:45 INFO - 'MOZ_NO_REMOTE': '1', 02:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:45 INFO - 'NO_EM_RESTART': '1', 02:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:45 INFO - 'PWD': '/builds/slave/test', 02:28:45 INFO - 'SHELL': '/bin/bash', 02:28:45 INFO - 'SHLVL': '1', 02:28:45 INFO - 'TERM': 'linux', 02:28:45 INFO - 'TMOUT': '86400', 02:28:45 INFO - 'USER': 'cltbld', 02:28:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 02:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:45 INFO - '_': '/tools/buildbot/bin/python'} 02:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:45 INFO - Downloading/unpacking blobuploader==1.2.4 02:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:47 INFO - Downloading blobuploader-1.2.4.tar.gz 02:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:28:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:28:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:48 INFO - Downloading docopt-0.6.1.tar.gz 02:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:28:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:28:48 INFO - Running setup.py install for blobuploader 02:28:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:28:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:28:48 INFO - Running setup.py install for requests 02:28:49 INFO - Running setup.py install for docopt 02:28:49 INFO - Successfully installed blobuploader requests docopt 02:28:49 INFO - Cleaning up... 02:28:49 INFO - Return code: 0 02:28:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:49 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 0x7fbf2ce9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf1c0>, '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 0x15c00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0550>, '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': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:28:49 INFO - Using env: {'DISPLAY': ':0', 02:28:49 INFO - 'HOME': '/home/cltbld', 02:28:49 INFO - 'LANG': 'en_US.UTF-8', 02:28:49 INFO - 'LANGUAGE': 'en_US:en', 02:28:49 INFO - 'LOGNAME': 'cltbld', 02:28:49 INFO - 'MAIL': '/var/mail/cltbld', 02:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:49 INFO - 'MOZ_NO_REMOTE': '1', 02:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:49 INFO - 'NO_EM_RESTART': '1', 02:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:49 INFO - 'PWD': '/builds/slave/test', 02:28:49 INFO - 'SHELL': '/bin/bash', 02:28:49 INFO - 'SHLVL': '1', 02:28:49 INFO - 'TERM': 'linux', 02:28:49 INFO - 'TMOUT': '86400', 02:28:49 INFO - 'USER': 'cltbld', 02:28:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 02:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:49 INFO - '_': '/tools/buildbot/bin/python'} 02:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:49 INFO - Running setup.py (path:/tmp/pip-q0Y1bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:49 INFO - Running setup.py (path:/tmp/pip-t8Av8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:49 INFO - Running setup.py (path:/tmp/pip-Ks_jf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:49 INFO - Running setup.py (path:/tmp/pip-6NOsh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:49 INFO - Running setup.py (path:/tmp/pip-nSaEst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:49 INFO - Running setup.py (path:/tmp/pip-uykMvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:49 INFO - Running setup.py (path:/tmp/pip-iLh38g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:49 INFO - Running setup.py (path:/tmp/pip-eTwg26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:49 INFO - Running setup.py (path:/tmp/pip-BeLJF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:50 INFO - Running setup.py (path:/tmp/pip-OLaObw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:50 INFO - Running setup.py (path:/tmp/pip-_b8JJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:50 INFO - Running setup.py (path:/tmp/pip-6d6noh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:50 INFO - Running setup.py (path:/tmp/pip-8FPpjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:50 INFO - Running setup.py (path:/tmp/pip-Ju73Vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:50 INFO - Running setup.py (path:/tmp/pip-FXldZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:50 INFO - Running setup.py (path:/tmp/pip-zl9TUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:50 INFO - Running setup.py (path:/tmp/pip-0bLOM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:28:50 INFO - Running setup.py install for manifestparser 02:28:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:28:50 INFO - Running setup.py install for mozcrash 02:28:50 INFO - Running setup.py install for mozdebug 02:28:50 INFO - Running setup.py install for mozdevice 02:28:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Running setup.py install for mozfile 02:28:51 INFO - Running setup.py install for mozhttpd 02:28:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Running setup.py install for mozinfo 02:28:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Running setup.py install for mozInstall 02:28:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Running setup.py install for mozleak 02:28:51 INFO - Running setup.py install for mozlog 02:28:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Running setup.py install for moznetwork 02:28:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Running setup.py install for mozprocess 02:28:51 INFO - Running setup.py install for mozprofile 02:28:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:28:51 INFO - Running setup.py install for mozrunner 02:28:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:28:52 INFO - Running setup.py install for mozscreenshot 02:28:52 INFO - Running setup.py install for moztest 02:28:52 INFO - Running setup.py install for mozversion 02:28:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:28:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:28:52 INFO - Cleaning up... 02:28:52 INFO - Return code: 0 02:28:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:52 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 0x7fbf2ce9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf1c0>, '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 0x15c00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0550>, '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': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:28:52 INFO - Using env: {'DISPLAY': ':0', 02:28:52 INFO - 'HOME': '/home/cltbld', 02:28:52 INFO - 'LANG': 'en_US.UTF-8', 02:28:52 INFO - 'LANGUAGE': 'en_US:en', 02:28:52 INFO - 'LOGNAME': 'cltbld', 02:28:52 INFO - 'MAIL': '/var/mail/cltbld', 02:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:52 INFO - 'MOZ_NO_REMOTE': '1', 02:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:52 INFO - 'NO_EM_RESTART': '1', 02:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:52 INFO - 'PWD': '/builds/slave/test', 02:28:52 INFO - 'SHELL': '/bin/bash', 02:28:52 INFO - 'SHLVL': '1', 02:28:52 INFO - 'TERM': 'linux', 02:28:52 INFO - 'TMOUT': '86400', 02:28:52 INFO - 'USER': 'cltbld', 02:28:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 02:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:52 INFO - '_': '/tools/buildbot/bin/python'} 02:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:52 INFO - Running setup.py (path:/tmp/pip-sLzpet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:52 INFO - Running setup.py (path:/tmp/pip-JGHHWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:52 INFO - Running setup.py (path:/tmp/pip-w5pkTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:52 INFO - Running setup.py (path:/tmp/pip-X83P9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:52 INFO - Running setup.py (path:/tmp/pip-FxbnuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:52 INFO - Running setup.py (path:/tmp/pip-JMpxPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:53 INFO - Running setup.py (path:/tmp/pip-1kIcDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:53 INFO - Running setup.py (path:/tmp/pip-d9krqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:53 INFO - Running setup.py (path:/tmp/pip-9XVzG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:53 INFO - Running setup.py (path:/tmp/pip-xVfno0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:53 INFO - Running setup.py (path:/tmp/pip-laWH3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:53 INFO - Running setup.py (path:/tmp/pip-_46Iig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:53 INFO - Running setup.py (path:/tmp/pip-9GuAHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:53 INFO - Running setup.py (path:/tmp/pip-qATanY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:53 INFO - Running setup.py (path:/tmp/pip-ddn3a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:53 INFO - Running setup.py (path:/tmp/pip-EuGRCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:53 INFO - Running setup.py (path:/tmp/pip-ZO2BLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:28:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:55 INFO - Downloading blessings-1.6.tar.gz 02:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:28:55 INFO - Installing collected packages: blessings 02:28:55 INFO - Running setup.py install for blessings 02:28:55 INFO - Successfully installed blessings 02:28:55 INFO - Cleaning up... 02:28:56 INFO - Return code: 0 02:28:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:28:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:56 INFO - Reading from file tmpfile_stdout 02:28:56 INFO - Current package versions: 02:28:56 INFO - argparse == 1.2.1 02:28:56 INFO - blessings == 1.6 02:28:56 INFO - blobuploader == 1.2.4 02:28:56 INFO - docopt == 0.6.1 02:28:56 INFO - functools32 == 3.2.3-2 02:28:56 INFO - jsonschema == 2.5.1 02:28:56 INFO - manifestparser == 1.1 02:28:56 INFO - mozInstall == 1.12 02:28:56 INFO - mozcrash == 0.17 02:28:56 INFO - mozdebug == 0.1 02:28:56 INFO - mozdevice == 0.48 02:28:56 INFO - mozfile == 1.2 02:28:56 INFO - mozhttpd == 0.7 02:28:56 INFO - mozinfo == 0.9 02:28:56 INFO - mozleak == 0.1 02:28:56 INFO - mozlog == 3.2 02:28:56 INFO - moznetwork == 0.27 02:28:56 INFO - mozprocess == 0.22 02:28:56 INFO - mozprofile == 0.28 02:28:56 INFO - mozrunner == 6.11 02:28:56 INFO - mozscreenshot == 0.1 02:28:56 INFO - mozsystemmonitor == 0.3 02:28:56 INFO - moztest == 0.7 02:28:56 INFO - mozversion == 1.4 02:28:56 INFO - psutil == 3.1.1 02:28:56 INFO - requests == 1.2.3 02:28:56 INFO - wsgiref == 0.1.2 02:28:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:56 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 0x7fbf2ce9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf1c0>, '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 0x15c00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0550>, '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': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:28:56 INFO - Using env: {'DISPLAY': ':0', 02:28:56 INFO - 'HOME': '/home/cltbld', 02:28:56 INFO - 'LANG': 'en_US.UTF-8', 02:28:56 INFO - 'LANGUAGE': 'en_US:en', 02:28:56 INFO - 'LOGNAME': 'cltbld', 02:28:56 INFO - 'MAIL': '/var/mail/cltbld', 02:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:56 INFO - 'MOZ_NO_REMOTE': '1', 02:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:56 INFO - 'NO_EM_RESTART': '1', 02:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:56 INFO - 'PWD': '/builds/slave/test', 02:28:56 INFO - 'SHELL': '/bin/bash', 02:28:56 INFO - 'SHLVL': '1', 02:28:56 INFO - 'TERM': 'linux', 02:28:56 INFO - 'TMOUT': '86400', 02:28:56 INFO - 'USER': 'cltbld', 02:28:56 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 02:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:56 INFO - '_': '/tools/buildbot/bin/python'} 02:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:28:56 INFO - Cleaning up... 02:28:56 INFO - Return code: 0 02:28:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf2ce9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf1c0>, '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 0x15c00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0550>, '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': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:28:56 INFO - Using env: {'DISPLAY': ':0', 02:28:56 INFO - 'HOME': '/home/cltbld', 02:28:56 INFO - 'LANG': 'en_US.UTF-8', 02:28:56 INFO - 'LANGUAGE': 'en_US:en', 02:28:56 INFO - 'LOGNAME': 'cltbld', 02:28:56 INFO - 'MAIL': '/var/mail/cltbld', 02:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:56 INFO - 'MOZ_NO_REMOTE': '1', 02:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:56 INFO - 'NO_EM_RESTART': '1', 02:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:56 INFO - 'PWD': '/builds/slave/test', 02:28:56 INFO - 'SHELL': '/bin/bash', 02:28:56 INFO - 'SHLVL': '1', 02:28:56 INFO - 'TERM': 'linux', 02:28:56 INFO - 'TMOUT': '86400', 02:28:56 INFO - 'USER': 'cltbld', 02:28:56 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 02:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:56 INFO - '_': '/tools/buildbot/bin/python'} 02:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:28:56 INFO - Cleaning up... 02:28:56 INFO - Return code: 0 02:28:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf2ce9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf1c0>, '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 0x15c00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0550>, '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': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:28:56 INFO - Using env: {'DISPLAY': ':0', 02:28:56 INFO - 'HOME': '/home/cltbld', 02:28:56 INFO - 'LANG': 'en_US.UTF-8', 02:28:56 INFO - 'LANGUAGE': 'en_US:en', 02:28:56 INFO - 'LOGNAME': 'cltbld', 02:28:56 INFO - 'MAIL': '/var/mail/cltbld', 02:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:56 INFO - 'MOZ_NO_REMOTE': '1', 02:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:56 INFO - 'NO_EM_RESTART': '1', 02:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:56 INFO - 'PWD': '/builds/slave/test', 02:28:56 INFO - 'SHELL': '/bin/bash', 02:28:56 INFO - 'SHLVL': '1', 02:28:56 INFO - 'TERM': 'linux', 02:28:56 INFO - 'TMOUT': '86400', 02:28:56 INFO - 'USER': 'cltbld', 02:28:56 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 02:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:56 INFO - '_': '/tools/buildbot/bin/python'} 02:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:56 INFO - Downloading/unpacking flake8 02:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:28:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:28:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:28:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:28:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:28:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:28:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:28:59 INFO - no previously-included directories found matching 'docs/_build' 02:28:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:28:59 INFO - Running setup.py install for pep8 02:28:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:28:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:28:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:28:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:28:59 INFO - no previously-included directories found matching 'docs/_build' 02:28:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:28:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:28:59 INFO - Cleaning up... 02:28:59 INFO - Return code: 0 02:28:59 INFO - Running post-action listener: _resource_record_post_action 02:28:59 INFO - Running post-action listener: _start_resource_monitoring 02:28:59 INFO - Starting resource monitoring. 02:28:59 INFO - ##### 02:28:59 INFO - ##### Finished create-virtualenv step (success) 02:28:59 INFO - ##### 02:28:59 INFO - ##### 02:28:59 INFO - ##### Running install step. 02:28:59 INFO - ##### 02:28:59 INFO - Running pre-action listener: _resource_record_pre_action 02:28:59 INFO - Running main action method: install 02:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:00 INFO - Reading from file tmpfile_stdout 02:29:00 INFO - Detecting whether we're running mozinstall >=1.0... 02:29:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:29:00 INFO - Reading from file tmpfile_stdout 02:29:00 INFO - Output received: 02:29:00 INFO - Usage: mozinstall [options] installer 02:29:00 INFO - Options: 02:29:00 INFO - -h, --help show this help message and exit 02:29:00 INFO - -d DEST, --destination=DEST 02:29:00 INFO - Directory to install application into. [default: 02:29:00 INFO - "/builds/slave/test"] 02:29:00 INFO - --app=APP Application being installed. [default: firefox] 02:29:00 INFO - mkdir: /builds/slave/test/build/application 02:29:00 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'] 02:29:00 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 02:29:15 INFO - Reading from file tmpfile_stdout 02:29:15 INFO - Output received: 02:29:15 INFO - /builds/slave/test/build/application/firefox/firefox 02:29:15 INFO - Running post-action listener: _resource_record_post_action 02:29:15 INFO - ##### 02:29:15 INFO - ##### Finished install step (success) 02:29:15 INFO - ##### 02:29:15 INFO - ##### 02:29:15 INFO - ##### Running run-tests step. 02:29:15 INFO - ##### 02:29:15 INFO - Running pre-action listener: _resource_record_pre_action 02:29:15 INFO - Running main action method: run_tests 02:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:29:15 INFO - Python 2.7.3 02:29:15 INFO - Return code: 0 02:29:15 INFO - grabbing minidump binary from tooltool 02:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:15 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 0x15bf1c0>, '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 0x15c00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:29:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:29:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:29:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:29:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:29:16 INFO - Return code: 0 02:29:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:29:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:29:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:29:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:29:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:29:16 INFO - Return code: 0 02:29:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:29:16 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:29:16 INFO - Using env: {'DISPLAY': ':0', 02:29:16 INFO - 'HOME': '/home/cltbld', 02:29:16 INFO - 'LANG': 'en_US.UTF-8', 02:29:16 INFO - 'LANGUAGE': 'en_US:en', 02:29:16 INFO - 'LOGNAME': 'cltbld', 02:29:16 INFO - 'MAIL': '/var/mail/cltbld', 02:29:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:29:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:16 INFO - 'MOZ_NO_REMOTE': '1', 02:29:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:16 INFO - 'NO_EM_RESTART': '1', 02:29:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:16 INFO - 'PWD': '/builds/slave/test', 02:29:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:29:16 INFO - 'SHELL': '/bin/bash', 02:29:16 INFO - 'SHLVL': '1', 02:29:16 INFO - 'TERM': 'linux', 02:29:16 INFO - 'TMOUT': '86400', 02:29:16 INFO - 'USER': 'cltbld', 02:29:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212', 02:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:16 INFO - '_': '/tools/buildbot/bin/python'} 02:29:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:29:17 INFO - mozversion application_buildid: 20160606202128 02:29:17 INFO - mozversion application_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:29:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:29:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:29:17 INFO - mozversion application_name: Firefox 02:29:17 INFO - mozversion application_remotingname: firefox-dev 02:29:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:29:17 INFO - mozversion application_vendor: Mozilla 02:29:17 INFO - mozversion application_version: 49.0a2 02:29:17 INFO - mozversion platform_buildid: 20160606202128 02:29:17 INFO - mozversion platform_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:29:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:29:17 INFO - mozversion platform_version: 49.0a2 02:29:17 INFO - using testdate: 1465291757 02:29:17 INFO - actual date: 1465291757 02:29:17 INFO - starting webserver on 'localhost:41189' 02:29:17 INFO - SUITE-START | Running 2 tests 02:29:17 INFO - TEST-START | dromaeo_css 02:29:17 INFO - operating with platform_type : linux_ 02:29:17 INFO - Initialising browser for dromaeo_css test... 02:29:17 INFO - TEST-INFO | started process 8686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwBp2E8/profile http://localhost:41189/getInfo.html) 02:29:21 INFO - PROCESS | 8686 | __metrics Screen width/height:1600/1200 02:29:21 INFO - PROCESS | 8686 | colorDepth:24 02:29:21 INFO - PROCESS | 8686 | Browser inner width/height: 1024/697 02:29:21 INFO - PROCESS | 8686 | __metrics 02:29:22 ERROR - PROCESS | 8686 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 02:29:23 INFO - TEST-INFO | 8686: exit 0 02:29:23 INFO - Browser initialized. 02:29:23 INFO - Running cycle 1/1 for dromaeo_css test... 02:29:23 INFO - TEST-INFO | started process 8817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwBp2E8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:35 INFO - PROCESS | 8817 | RSS: Main: 155901952 02:29:35 INFO - PROCESS | 8817 | 02:30:24 INFO - PROCESS | 8817 | 1465291824828 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:32:32 INFO - PROCESS | 8817 | Cycle 1(1): loaded http://localhost:41189/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41189/tests/dromaeo/cssquery-ext.html) 02:32:33 INFO - PROCESS | 8817 | RSS: Main: 159662080 02:32:33 INFO - PROCESS | 8817 | 02:35:35 INFO - PROCESS | 8817 | Cycle 1(1): loaded http://localhost:41189/tests/dromaeo/cssquery-ext.html (next: http://localhost:41189/tests/dromaeo/cssquery-jquery.html) 02:35:36 INFO - PROCESS | 8817 | RSS: Main: 157528064 02:35:36 INFO - PROCESS | 8817 | 02:38:38 INFO - PROCESS | 8817 | Cycle 1(1): loaded http://localhost:41189/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41189/tests/dromaeo/cssquery-mootools.html) 02:38:38 INFO - PROCESS | 8817 | RSS: Main: 157106176 02:38:38 INFO - PROCESS | 8817 | 02:41:40 INFO - PROCESS | 8817 | Cycle 1(1): loaded http://localhost:41189/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41189/tests/dromaeo/cssquery-prototype.html) 02:41:41 INFO - PROCESS | 8817 | RSS: Main: 156778496 02:41:41 INFO - PROCESS | 8817 | 02:44:43 INFO - PROCESS | 8817 | Cycle 1(1): loaded http://localhost:41189/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41189/tests/dromaeo/cssquery-yui.html) 02:44:44 INFO - PROCESS | 8817 | RSS: Main: 159252480 02:44:44 INFO - PROCESS | 8817 | 02:47:46 INFO - PROCESS | 8817 | Cycle 1(1): loaded http://localhost:41189/tests/dromaeo/cssquery-yui.html (next: http://localhost:41189/tests/dromaeo/cssquery-dojo.html) 02:47:46 INFO - PROCESS | 8817 | RSS: Main: 159227904 02:47:46 INFO - PROCESS | 8817 | 02:47:46 INFO - PROCESS | 8817 | __start_tp_report 02:47:46 INFO - PROCESS | 8817 | _x_x_mozilla_page_load 02:47:46 INFO - PROCESS | 8817 | _x_x_mozilla_page_load_details 02:47:46 INFO - PROCESS | 8817 | |i|pagename|runs| 02:47:46 INFO - PROCESS | 8817 | |0;dojo.html;3388.88138915138;3416.5046068320103;3435.433153529668;3440.5355277037625;3466.705330046946;5804.59367844251;5805.796797112102;5819.447152520509;5837.649741015542;5901.05583106703;5818.272715910512;5866.76532938682;5872.7944521941745;5913.083472061827;5921.585489015771;5229.372475302969;5296.470352964711;5318.6011049171275;5353.384360798519;5355.7857685692525;5221.843344699665;5244.580433565325;5309.522143007129;5355.973220133894;5376.542993845528;5294.232336311233;5303.867403314909;5324.7071411072375;5333.893322133555;5340.706261155635;5392.973035134819;5400.513953744143;5401.459854014606;5419.864503387407;5420.24116623671;5098.643094983353;5155.226715992631;5202.92195617066;5306.389765176977;5314.840554783363;5604.3835178130375;5633.943660563424;5657.745401456944;5683.232763576905;5695.77216911323;6133.325334213233;6164.660943648098;6170.7223174957235;6171.796499682564;6187.597806142587;5991.071383935497;6202.658853763041;6212.565120441571;6276.560640755149;6283.246010478726;5886.941130588682;5890.087036509348;5892.204552385416;5925.792597259076;5954.583179177459;6357.6145727339945;6386.776462823779;6406.775762848278;6409.102725618417;6418.133551970424;6015.1278064681255;6108.3280839107665;6111.04482360895;6127.754889804358;6220.03589443637;6311.463525600284;6335.809925702236;6339.175907132043;6341.3341599132345;6344.777932772423;5908.172855800191;6270.968645156836;6336.144620476269;6337.556371053982;6342.619442833353;6147.323794382614;6159;6187;6290.496760259169;6333.2716737575765;4657.417822772153;4776.402949631296;4783.5933945614315;4806.44725856524;4811.518848115161;4187.560306167869;4207.053412982054;4250;4258.7657678827345;4270.274053410865;5777.508911742465;5909.349971503131;5945.4649081582;6051.636901785907;6074.574779765374;6214.728697628956;6254.2807577129215;6277.780277690259;6283.277423096311;6284.685765711696;5759.481646651821;5853.560982926298;5995.190649262294;6009.579329446897;6015.218021657244;5414.133738601805;5415.241866138744;5435.347758268954;5452.536534394541;5461.890762184734;6539.869202615921;6585.045168450548;6598.340165983459;6609.5373323867825;6632.767853125118;6085.908711369421;6139.9079013813935;6301.243850737941;6362.491000719839;6367.522435817332;6326.177596912372;6443.452306553995;6453.128827608401;6459.806205813833;6471.935280647133;6055.969720151371;6106.206193195034;6108.419700128481;6123.357047509948;6130.2030736004035;6046;6208.689565521616;6231.096491008688;6236.844078898064;6254.155024267943;6153.723082461211;6178.876422471435;6187.535934804998;6189.6286222826775;6192;6130.877382452237;6145.569810113249;6148.815535533941;6168;6178.382161783786;5791.305043394819;5927;5955;6012.518998480024;6037.426444487766;6168.962067403751;6173.876522469615;6213.844653883689;6220;6220.7511699531515;6075.668877543261;6079.179310792986;6090.725917333819;6102.084687296941;6120.632762034292 02:47:46 INFO - PROCESS | 8817 | |1;ext.html;589.4341432225063;646.7316063833509;652.9738810447583;659.2221179008768;673.0039541478611;46755.76622116893;48391.75804120983;48420.2736958945;51966;52195.478045219534;46662.53337466624;46824.53175468253;47213;47441.76279118608;47570.76214618931;9040.593173307185;9195.816083678323;9235.307351948597;9241.630334786634;9250.213731832802;9186.54067296636;9236.168744812965;9292.628294868196;9293;9308.720738377859;9112.362134650577;9309.208717259042;9332.813343733154;9350.485723285217;9364.625414983426;9250.121238482334;9299.209567186763;9305.860412093823;9307.11582399671;9318.72043838686;9003.324750643727;9127.087291270886;9128.224100951427;9140.817183656356;9145.314101442353;46669.53330466686;46699;47000;47005;47084.293735593994;3743.401055831054;3778.1688028633657;3827.4067519534515;3909.5113110861143;4462.152191083716;35132.121696957525;35355.64644353575;35357.4696379552;35670.46494302587;36764;4672.392588963413;4783.952160478386;4806.303086052503;4808.3027960945465;4832.275158726184;384701;388632;389575.99999999715;390863;391549;38832.22335553273;69096.6545167281;69231.30768692249;69509.21963121419;70011.2998870015;40830.38754418686;40879.591204088174;40915;40951.59048409478;41186.58813411887;16070.75893861593;16073.437429690139;16107.355705771637;16172.83827161737;16211.351545938267;13943.511977080754;14000.859991400159;14051.297435128203;14117.43530258778;14265.42938282457;9356.34505584616;9359.532023398802;9376.671816486527;9465.90534094664;9469.715908522618;3568.4647302904773;3632.164602141522;3643.8178091095338;3655.597884232732;3668.669819716238;1051.4374809477047;1114.3578822247664;1115.6764538283808;1115.8214685650419;1168.6318809574957;33723.49414758781;33951.830240848634;34264.828675856465;34964;34978.125546861535;1168.4041139019162;1192.5945178639304;1244.9604580175474;1253.674044748372;1306.137948953686;17974;18111.45665630033;18285.725714114298;18344.266229350676;18411.63176736458;625989;636258;658165;658783;659857;63896.68051659712;69820;70194.2980570198;70715;70932.64533677402;1447.7973083768281;1481.9851801481848;1483.9777403338958;1501.5570406730042;1512.1456377146876;33893.66106338905;35422.822885885405;35625.109372264866;35816.82091589525;36093.819530902176;60851.39148608457;61229.38770612237;61325.38674613197;61365.386346135965;61438;561592;564092;565281;565595;567764;50586.24120638267;50901.98196036133;51327.230091549405;52126.478735212164;52391.47608524018;55393;55819.16271256016;56276;56326.155107672595;56617.15074273807;45269.56617122789;45854;45949.770251149865;46816.7659161702;47514;44865;45303.77348113238;45490.77254613706;45995.540044600464;46748.7662561685;45779.31331029971;46348;46789.064218716114;47050.29424558566;47090.76454617705;39883.60116398799;40050.79974600225;40177.99110044545;40781.1843763129;41955.37066944059;30461.390772184874;30658.233544161576;30943.226419339695;31145;31151 02:47:46 INFO - PROCESS | 8817 | |2;jquery.html;428.76632235431686;430.4812700695661;431.9591390003648;435.449156816627;435.9782010899454;19148.521286967833;20684.689729654066;21040.579188416243;22108.22621208258;22159.44601384966;19585.706214406797;19860.60278794427;21015.47461313468;21108.472288192803;21141.788582114175;5756.194132821408;5950.9107363389585;5955.940440595582;5982.581219314649;5988.580799344048;5805.622634528763;5832.558790313714;5901.49837263831;5924.703764811742;5940.613860099102;5774.913376299359;5842.824715258528;5848.1812546243345;5869.618474799146;5879;5491.533219676332;5824.301083869942;5841.8831623367505;5853.619514731571;5933.050711886078;5589.245451863987;5697;5743.253377060997;5813.128030795372;5825.533957283407;14809.407623695039;15003.32485038176;15339.846601533953;24966.750332496624;25068.874655626605;2408.506256217471;2417.492326611414;2440.1825388494876;2491.314888405685;2516.6854143232094;10972.451377431096;11016.11871050322;11115.777684446266;11127;11151.498182581803;1886.8584856135844;2014.1842553765748;2044.6626306659384;2089.6238677038127;2095.2666566701687;70196;88257;90472.54763726205;91124.54437727769;92282.53858730731;10833.349999000086;10847.132229421784;10959.232853700165;11071.391073491035;11815.11386646005;14553.345099470549;14636.634084147769;14672.266386680623;14799.92600036993;14826.925865370604;8761.605727742266;8849.51327676971;8880.289576833839;8906.421082629608;9071.59177836999;8728.694495692747;8758.824823503493;8820.33847461443;8822.073682263399;8831.337649676172;4631.328457373662;4632.698874573142;4723.173444647173;4723.551262630113;4810.062037902575;2065.8037486439066;2089.9268525601533;2114.1649048626014;2119.9258025969016;2136.903839327234;458.40407470288494;940.5908429833045;993.6323560282742;1080.6271836216492;1136.1933027550367;11973.16187866841;12072.637820865388;12730.98152147826;13080.738385232242;13133.277669728257;491.26555799079887;496.92546118081856;497.45280191789465;502.2892606961109;505.8608882557253;6793.252742198354;6984.126984126984;7083.858322833515;7084.610346430893;7143.464240182007;501646;508330;513162;549527;563561;82030;86792.56603716941;93825.5308723452;93828;112806;1099.0493223361734;1120.8767035626074;1126.633844000703;1127.1546340244815;1132.388510204497;18597.81402185961;18598.81401186025;18606;18636.254549817855;18927.810721892605;43698.34452483279;44632.55367446284;44776.328355074045;45185;45611.77194114008;60410.39589604048;61553.38446615476;64927;65298.347016529224;66694.33305666881;9110.544472776468;9160.58777355034;9167.312451566026;9299.67451139207;9344.252459803063;12378.504859805867;14011.719765604426;14201.715965680834;14260.358283877044;14275.785863212268;12089.214201076902;12229.266244025386;12240.632781016584;12591.181573197713;12834;11905.642830715093;11997.40012999364;12293.75412491763;12402.503899844267;12553.874461255637;12400.069994750611;12577.496900124259;12604.810927836274;12689;12797.552085676956;9240;9267;9309.581068852054;9341.252699783865;9380.3902746324;9612.086851749073;11654.53381864716;12038.217515861441;12731.745365092831;13163.078584498993 02:47:46 INFO - PROCESS | 8817 | |3;mootools.html;1567.7491601343784;1580.044073335632;1812.5378028602704;1897.9430617081493;1905.361703829218;9353.204977576906;9617.615295388176;9673.661421850236;9770.218382529398;10048.748781280472;9723.902760972389;9791.755206119851;9884.604615815359;9911.355761875473;9969.10278074973;2524.558202314592;2547.6942766868;2549.8725063746833;2550.387906902339;2563.2566555698827;2493.7132229793624;2532.5947848344267;2550.183941138827;2554.7572980566815;2557.897684092634;2445.7187423446267;2467.580511313081;2481.2184161988916;2482.441450673593;2486.813488988333;2416.347586151738;2430.1130087518104;2457.1154384421593;2461.88921498533;2467.4324905271887;2413.818963577721;2442.8778561072054;2443.9511209775706;2469.530789150074;2477.380654836291;9825.213982881352;9908.801823963553;9971.700848974542;9975.700728978143;10030.197584193247;5736.541076713853;5919.911201331984;5920.437558431942;5920.526357891358;5921.993261145615;3782.527184101987;3877.011362102674;3897.2400381925536;3923.470331505239;3969.2458432897656;1213.993930030353;1240.7084335181225;1250.0749445410331;1255.579380907397;1282.724214293922;13905.513307034205;14203.573892783234;14208.786868196985;14211.147331160164;14376.784348234889;4884.462709101996;4923.384576927884;4946.035523073038;4975.129352363322;5031.144705400091;10686.51910664022;10718.517666705016;10783.299085559414;10784.78430431387;10819.404932728776;5789.8552536186935;5885.882282354329;5895.911561326584;5897.705114744245;5898.911516327258;4599.126166028444;5301.734913254322;5411.83764487066;5426.538744206708;5472.288602481732;4153.086321009373;4187.937180942288;4223.831046758157;4230.407742915994;4242.851500197478;1221.6212973978095;1227.3065717869374;1232.8212409200617;1236.8763123687559;1254.084518301645;912.2428384440898;950.5247376311844;1098.2696506822874;1112.7551938573502;1141.9257748246337;6608.86782264352;6812.1144251248015;6864.931350686529;6916.412104971134;7107.182673992454;1054.8681414823147;1068.433730123036;1076.3918386111823;1103.2222283290262;1106.0985296982933;4461.219286624828;4698.436187657435;4722.95277047232;4738.431388233434;4791.257355109963;11925.403729813648;12288.508459661693;12301.384930753427;12711.682207944876;12810.615681529569;12491.875081249253;12649.557265495663;12659.810102848465;12682.746345073047;12706.618801435972;9111.863322050174;9267.25861931044;9268.860967085498;9316.813663726687;9324.766880828034;6856.348646878539;6953.269906659728;6977.651117444209;7047.224805271314;7069.081019467436;11381.54473821038;11690.064794816564;11792.705182370166;11886;11944.522219111139;11753.471093800628;11902.523899044287;11912.40437978115;12030.819537706766;12066.034717222425;8135.83728325442;8464.153584641486;8778.604962776562;8823.117688231125;9011.324150688593;9709.805803884024;9734.513274336396;9752.073553012453;9760.170385517311;9765.414075155513;8534.70128545498;8718.17177368149;8815.823683526165;8828.514431706319;8849.159329863653;8503.74488765338;8524.445911015764;8770.91229087701;8777.605007774539;8955.731328060168;7901.565413902291;7915.802104947423;7938.761837144895;7939.761807145795;7964.800879978047;5702.800401985911;5772.365039845529;5803.7968671096305;5816.476517113311;5874.03078492044;5843.620164689281;5851.824445266649;5877.500412464989;5923.555733319932;5963.612365196422 02:47:46 INFO - PROCESS | 8817 | |4;prototype.html;354.2861134813352;361.0684434159868;365.73301489912365;366.21446996193174;368.7437231124366;5639.351474580424;5756.222909907161;5763.221965034719;5833.824985250444;5857.619254748443;5772.480476757091;5802.39074897136;5829.533637309016;5837.883242335161;5841.561882858781;4418.624416924566;4467.173572889026;4485.932711009321;4486.237339652267;4489;4437.826953728084;4497.910041799162;4511.548845115479;4517.1417430688225;4520.660950428714;4425.911481770363;4463.754493502856;4472.485664148616;4482.798274077674;4487.842925497608;4437.5340589237985;4452.376667266585;4460.197164510387;4483.820647174109;4488.192125417424;3917.823697933571;3965.206958608261;3974.085960229135;3998.140399814054;4050.41269015991;5568.6658800472105;5597.7201139943245;5605.943940560583;5630.774769009235;5644.774209031634;5144.0740666679985;5153.536181743623;5161.354830646169;5178.818741344035;5211.5049070338255;5821.50517206038;6059.818205453844;6094.8781024379705;6099;6112.266528016667;4407;4422.093470838503;4422.7346359218545;4425.159219748238;4426.955730442719;6088.96955515224;6206.782762603287;6220.409061139185;6291.307956124822;6301.779437719658;4393.582609652142;4477.895389167086;4483.417155769729;4489.361383095212;4489.820407183742;4507.278835386388;4532.388127602798;4536.432945881765;4537.251353526697;4588.453408358327;5146.150885103991;5188.169892817131;5210.166373380241;5213.7393130343335;5245.186996015624;5758.395368486333;5920.437558431942;5962.07587823888;6107.175531303217;6126.785562505291;1565.0375019363237;1580.146720770794;1586.8175159856532;1589.4675283780064;1589.6105454163803;1015.6140666546813;1019.6125472320471;1021.4739409204266;1037.8028174646793;1048.6853943816825;5197.934423443185;5249.580033597303;5260.947810437928;5262.842234683838;5291.814786482455;5546.722663866791;5549.916751248735;5587.658961849208;5590.5248053915875;5647.519960803295;5319.547838433699;5323.642471169827;5591.916121258185;5970;6058.4244496772735;3306.983465082659;3335.766496345281;3372.6458721834347;3386.508956201337;3415.8121303328558;6188.412100850412;6518.967405163039;6541.28045914949;6552.967235163889;6582.058292803538;6333.46165575922;6416.7433302668305;6422.42198202164;6434.710438030206;6452.6451045192025;6362.745490180341;6448.645324507103;6468.477293855401;6474.1907261592305;6513.576617519846;6188.81433556994;6225;6225.595336303126;6258.374162583706;6332.651704156316;6010.579259451796;6152.600080994721;6202.81391558254;6212.384779957153;6212.695333979915;6295.937040629535;6451.387153211697;6480.287168411377;6532.869342613026;6539.411452969065;4408.779561022;4426.933595996127;4453.421055262925;4453.977730111329;4459.509453960127;5959.418912094019;6293.804177206316;6364.427201551883;6371.39471750183;6393.808185754435;6120.785772497941;6162.845928851635;6168.563417450172;6171.59884607499;6178.980468222693;6050.576459647782;6126.540509461897;6131.63210207389;6132.2947860996555;6149.200603921461;5877.795052014412;5984.730687119003;5987.64074155552;5991.880162396815;5994.910076348771;6123.387661233841;6131.601445906002;6134.141220229082;6135.601185922901;6194.4115309045565;5927.4665280125;5993.940060599512;6008.188894499187;6011.909821352596;6030.10051833671 02:47:46 INFO - PROCESS | 8817 | |5;yui.html;775.5075527040332;811.5333683132201;814.4543156085422;870.9390342676011;874.147705986663;15372;16318.83681163188;16672.16639168043;17325.913370433147;17700.91149544252;15984.280707368167;16031.438899638515;16099.114548699818;16100.919495402535;16160.191990400492;869.6608322754131;896.932730045246;908.1236606674557;915.2129168914728;916.2852974679761;902.1429641840245;906.1029580715077;909;911.9361644684875;912.2200518556638;942.9811403771955;949.0746522140892;951.3198063384679;955.7276176289758;956.1394744729764;936.091990768953;941.6092321686526;942.5428667096453;947.5499137909507;947.70147403568;694.437505620444;695.1102588686439;695.7808290388562;696.958182509046;698.4866123399297;16142.6278766305;16276.104814235212;16284;16308.184590770414;16330.591735206715;15705.164889302483;16097.597560060975;16189.83810161895;16208.83791162085;16215.756763648555;12971.156874803202;12996.41516131767;13291.601251962456;13466.596002119952;13539;4004.739691920016;4143.4199212110325;4161.875143745692;4172.123853990665;4216.198922204771;78133;78450.60774696147;79118;79607.60196198981;80193.19806801916;12368.75262494745;12374.690632734073;12454.31501267439;12499.062570307264;12535.31055791922;21955;21955.890220549114;22189.44526386821;22196.556068878534;22816.31551053471;8947.10528947113;8975.461472311683;9054.954725226331;9112.908870911338;9302.95348523253;4969.900601988013;5068.087744206005;5215.713135777492;5286.207068939613;5346.732663366816;3779.508663873679;3890;3954.9011274718364;3966.345552983783;3970.5235371755575;694.5520139509988;705.544923524324;707.678006507038;712.2734810493267;714.731975509184;639.5778786001217;648.5687018132888;760.2967255288836;787.6180052674448;792.2315354106507;10787.892121078845;11046.668599942015;11050.613228536962;11366.829497557543;11403.885961140282;677.8203775999364;720.121451828768;777.3690420711341;817.7996390884152;822.7655118291258;4688.64835137366;4739.218029025241;4751.809927602926;4788.266948877537;4882.707037577757;72049.6397518009;103459;117893.41053294679;118812;120176.3991180056;70420.94368584476;70951.64524177345;96592.51703741436;102470.48764756278;102752.48623756833;85765;86102;86716;87123;87809.56095219484;9563;9620.567074481525;9629.807403852024;9832.38439313574;9871.802563948537;53567.464325356246;54516.454835451135;55354.72322638361;56395.43604563902;57008;72601.6369918147;74127.62936185284;76810;77553.22446775685;80504.19495804967;12599.811002834782;12640.98872090249;12682.239065656091;12712;12879.227246365248;13697.931510342385;14533.563993080224;14863.18252496123;15098.924505377403;15239.466618668293;13078.346082695636;13085.280309583064;13202.537911173064;13548;13752.243626600633;13380.799288010883;13998.65003374883;14106.78839817383;14150.646233844236;14249.430022798972;13596.484680192156;13735.725285494034;13914.791278131039;13943.302834858014;14070.717493930673;11084.944575277072;11407.315561066363;11494.310341379543;11578.131640127192;11644.88355116438;11405.486753095965;11538.134639901873;11566.749826956975;11657.76684466289;11790.351530665552 02:47:46 INFO - PROCESS | 8817 | __end_tp_report 02:47:46 INFO - PROCESS | 8817 | __start_cc_report 02:47:46 INFO - PROCESS | 8817 | _x_x_mozilla_cycle_collect,340 02:47:46 INFO - PROCESS | 8817 | __end_cc_report 02:47:46 INFO - PROCESS | 8817 | __startTimestamp1465292866688__endTimestamp 02:47:46 INFO - PROCESS | 8817 | 02:47:46 INFO - PROCESS | 8817 | ------- Summary: start ------- 02:47:46 INFO - PROCESS | 8817 | Number of tests: 6 02:47:46 INFO - PROCESS | 8817 | 02:47:46 INFO - PROCESS | 8817 | [#0] dojo.html Cycles:165 Average:5807.77 Median:6051.64 stddev:660.77 (10.9%) stddev-sans-first:634.97 02:47:46 INFO - PROCESS | 8817 | Values: 3388.9 3416.5 3435.4 3440.5 3466.7 5804.6 5805.8 5819.4 5837.6 5901.1 5818.3 5866.8 5872.8 5913.1 5921.6 5229.4 5296.5 5318.6 5353.4 5355.8 5221.8 5244.6 5309.5 5356.0 5376.5 5294.2 5303.9 5324.7 5333.9 5340.7 5393.0 5400.5 5401.5 5419.9 5420.2 5098.6 5155.2 5202.9 5306.4 5314.8 5604.4 5633.9 5657.7 5683.2 5695.8 6133.3 6164.7 6170.7 6171.8 6187.6 5991.1 6202.7 6212.6 6276.6 6283.2 5886.9 5890.1 5892.2 5925.8 5954.6 6357.6 6386.8 6406.8 6409.1 6418.1 6015.1 6108.3 6111.0 6127.8 6220.0 6311.5 6335.8 6339.2 6341.3 6344.8 5908.2 6271.0 6336.1 6337.6 6342.6 6147.3 6159.0 6187.0 6290.5 6333.3 4657.4 4776.4 4783.6 4806.4 4811.5 4187.6 4207.1 4250.0 4258.8 4270.3 5777.5 5909.3 5945.5 6051.6 6074.6 6214.7 6254.3 6277.8 6283.3 6284.7 5759.5 5853.6 5995.2 6009.6 6015.2 5414.1 5415.2 5435.3 5452.5 5461.9 6539.9 6585.0 6598.3 6609.5 6632.8 6085.9 6139.9 6301.2 6362.5 6367.5 6326.2 6443.5 6453.1 6459.8 6471.9 6056.0 6106.2 6108.4 6123.4 6130.2 6046.0 6208.7 6231.1 6236.8 6254.2 6153.7 6178.9 6187.5 6189.6 6192.0 6130.9 6145.6 6148.8 6168.0 6178.4 5791.3 5927.0 5955.0 6012.5 6037.4 6169.0 6173.9 6213.8 6220.0 6220.8 6075.7 6079.2 6090.7 6102.1 6120.6 02:47:46 INFO - PROCESS | 8817 | 02:47:46 INFO - PROCESS | 8817 | [#1] ext.html Cycles:180 Average:70104.33 Median:46772.42 stddev:145173.76 (310.4%) stddev-sans-first:145487.19 02:47:46 INFO - PROCESS | 8817 | Values: 589.4 646.7 653.0 659.2 673.0 46755.8 48391.8 48420.3 51966.0 52195.5 46662.5 46824.5 47213.0 47441.8 47570.8 9040.6 9195.8 9235.3 9241.6 9250.2 9186.5 9236.2 9292.6 9293.0 9308.7 9112.4 9309.2 9332.8 9350.5 9364.6 9250.1 9299.2 9305.9 9307.1 9318.7 9003.3 9127.1 9128.2 9140.8 9145.3 46669.5 46699.0 47000.0 47005.0 47084.3 3743.4 3778.2 3827.4 3909.5 4462.2 35132.1 35355.6 35357.5 35670.5 36764.0 4672.4 4784.0 4806.3 4808.3 4832.3 384701.0 388632.0 389576.0 390863.0 391549.0 38832.2 69096.7 69231.3 69509.2 70011.3 40830.4 40879.6 40915.0 40951.6 41186.6 16070.8 16073.4 16107.4 16172.8 16211.4 13943.5 14000.9 14051.3 14117.4 14265.4 9356.3 9359.5 9376.7 9465.9 9469.7 3568.5 3632.2 3643.8 3655.6 3668.7 1051.4 1114.4 1115.7 1115.8 1168.6 33723.5 33951.8 34264.8 34964.0 34978.1 1168.4 1192.6 1245.0 1253.7 1306.1 17974.0 18111.5 18285.7 18344.3 18411.6 625989.0 636258.0 658165.0 658783.0 659857.0 63896.7 69820.0 70194.3 70715.0 70932.6 1447.8 1482.0 1484.0 1501.6 1512.1 33893.7 35422.8 35625.1 35816.8 36093.8 60851.4 61229.4 61325.4 61365.4 61438.0 561592.0 564092.0 565281.0 565595.0 567764.0 50586.2 50902.0 51327.2 52126.5 52391.5 55393.0 55819.2 56276.0 56326.2 56617.2 45269.6 45854.0 45949.8 46816.8 47514.0 44865.0 45303.8 45490.8 45995.5 46748.8 45779.3 46348.0 46789.1 47050.3 47090.8 39883.6 40050.8 40178.0 40781.2 41955.4 30461.4 30658.2 30943.2 31145.0 31151.0 02:47:46 INFO - PROCESS | 8817 | 02:47:46 INFO - PROCESS | 8817 | [#2] jquery.html Cycles:180 Average:30401.62 Median:435.71 stddev:87079.62 (19985.5%) stddev-sans-first:87294.82 02:47:46 INFO - PROCESS | 8817 | Values: 428.8 430.5 432.0 435.4 436.0 19148.5 20684.7 21040.6 22108.2 22159.4 19585.7 19860.6 21015.5 21108.5 21141.8 5756.2 5950.9 5955.9 5982.6 5988.6 5805.6 5832.6 5901.5 5924.7 5940.6 5774.9 5842.8 5848.2 5869.6 5879.0 5491.5 5824.3 5841.9 5853.6 5933.1 5589.2 5697.0 5743.3 5813.1 5825.5 14809.4 15003.3 15339.8 24966.8 25068.9 2408.5 2417.5 2440.2 2491.3 2516.7 10972.5 11016.1 11115.8 11127.0 11151.5 1886.9 2014.2 2044.7 2089.6 2095.3 70196.0 88257.0 90472.5 91124.5 92282.5 10833.3 10847.1 10959.2 11071.4 11815.1 14553.3 14636.6 14672.3 14799.9 14826.9 8761.6 8849.5 8880.3 8906.4 9071.6 8728.7 8758.8 8820.3 8822.1 8831.3 4631.3 4632.7 4723.2 4723.6 4810.1 2065.8 2089.9 2114.2 2119.9 2136.9 458.4 940.6 993.6 1080.6 1136.2 11973.2 12072.6 12731.0 13080.7 13133.3 491.3 496.9 497.5 502.3 505.9 6793.3 6984.1 7083.9 7084.6 7143.5 501646.0 508330.0 513162.0 549527.0 563561.0 82030.0 86792.6 93825.5 93828.0 112806.0 1099.0 1120.9 1126.6 1127.2 1132.4 18597.8 18598.8 18606.0 18636.3 18927.8 43698.3 44632.6 44776.3 45185.0 45611.8 60410.4 61553.4 64927.0 65298.3 66694.3 9110.5 9160.6 9167.3 9299.7 9344.3 12378.5 14011.7 14201.7 14260.4 14275.8 12089.2 12229.3 12240.6 12591.2 12834.0 11905.6 11997.4 12293.8 12402.5 12553.9 12400.1 12577.5 12604.8 12689.0 12797.6 9240.0 9267.0 9309.6 9341.3 9380.4 9612.1 11654.5 12038.2 12731.7 13163.1 02:47:46 INFO - PROCESS | 8817 | 02:47:46 INFO - PROCESS | 8817 | [#3] mootools.html Cycles:180 Average:6534.90 Median:4530.17 stddev:3788.92 (83.6%) stddev-sans-first:3781.16 02:47:46 INFO - PROCESS | 8817 | Values: 1567.7 1580.0 1812.5 1897.9 1905.4 9353.2 9617.6 9673.7 9770.2 10048.7 9723.9 9791.8 9884.6 9911.4 9969.1 2524.6 2547.7 2549.9 2550.4 2563.3 2493.7 2532.6 2550.2 2554.8 2557.9 2445.7 2467.6 2481.2 2482.4 2486.8 2416.3 2430.1 2457.1 2461.9 2467.4 2413.8 2442.9 2444.0 2469.5 2477.4 9825.2 9908.8 9971.7 9975.7 10030.2 5736.5 5919.9 5920.4 5920.5 5922.0 3782.5 3877.0 3897.2 3923.5 3969.2 1214.0 1240.7 1250.1 1255.6 1282.7 13905.5 14203.6 14208.8 14211.1 14376.8 4884.5 4923.4 4946.0 4975.1 5031.1 10686.5 10718.5 10783.3 10784.8 10819.4 5789.9 5885.9 5895.9 5897.7 5898.9 4599.1 5301.7 5411.8 5426.5 5472.3 4153.1 4187.9 4223.8 4230.4 4242.9 1221.6 1227.3 1232.8 1236.9 1254.1 912.2 950.5 1098.3 1112.8 1141.9 6608.9 6812.1 6864.9 6916.4 7107.2 1054.9 1068.4 1076.4 1103.2 1106.1 4461.2 4698.4 4723.0 4738.4 4791.3 11925.4 12288.5 12301.4 12711.7 12810.6 12491.9 12649.6 12659.8 12682.7 12706.6 9111.9 9267.3 9268.9 9316.8 9324.8 6856.3 6953.3 6977.7 7047.2 7069.1 11381.5 11690.1 11792.7 11886.0 11944.5 11753.5 11902.5 11912.4 12030.8 12066.0 8135.8 8464.2 8778.6 8823.1 9011.3 9709.8 9734.5 9752.1 9760.2 9765.4 8534.7 8718.2 8815.8 8828.5 8849.2 8503.7 8524.4 8770.9 8777.6 8955.7 7901.6 7915.8 7938.8 7939.8 7964.8 5702.8 5772.4 5803.8 5816.5 5874.0 5843.6 5851.8 5877.5 5923.6 5963.6 02:47:46 INFO - PROCESS | 8817 | 02:47:46 INFO - PROCESS | 8817 | [#4] prototype.html Cycles:180 Average:5090.08 Median:5635.06 stddev:1491.86 (26.5%) stddev-sans-first:1453.08 02:47:46 INFO - PROCESS | 8817 | Values: 354.3 361.1 365.7 366.2 368.7 5639.4 5756.2 5763.2 5833.8 5857.6 5772.5 5802.4 5829.5 5837.9 5841.6 4418.6 4467.2 4485.9 4486.2 4489.0 4437.8 4497.9 4511.5 4517.1 4520.7 4425.9 4463.8 4472.5 4482.8 4487.8 4437.5 4452.4 4460.2 4483.8 4488.2 3917.8 3965.2 3974.1 3998.1 4050.4 5568.7 5597.7 5605.9 5630.8 5644.8 5144.1 5153.5 5161.4 5178.8 5211.5 5821.5 6059.8 6094.9 6099.0 6112.3 4407.0 4422.1 4422.7 4425.2 4427.0 6089.0 6206.8 6220.4 6291.3 6301.8 4393.6 4477.9 4483.4 4489.4 4489.8 4507.3 4532.4 4536.4 4537.3 4588.5 5146.2 5188.2 5210.2 5213.7 5245.2 5758.4 5920.4 5962.1 6107.2 6126.8 1565.0 1580.1 1586.8 1589.5 1589.6 1015.6 1019.6 1021.5 1037.8 1048.7 5197.9 5249.6 5260.9 5262.8 5291.8 5546.7 5549.9 5587.7 5590.5 5647.5 5319.5 5323.6 5591.9 5970.0 6058.4 3307.0 3335.8 3372.6 3386.5 3415.8 6188.4 6519.0 6541.3 6553.0 6582.1 6333.5 6416.7 6422.4 6434.7 6452.6 6362.7 6448.6 6468.5 6474.2 6513.6 6188.8 6225.0 6225.6 6258.4 6332.7 6010.6 6152.6 6202.8 6212.4 6212.7 6295.9 6451.4 6480.3 6532.9 6539.4 4408.8 4426.9 4453.4 4454.0 4459.5 5959.4 6293.8 6364.4 6371.4 6393.8 6120.8 6162.8 6168.6 6171.6 6179.0 6050.6 6126.5 6131.6 6132.3 6149.2 5877.8 5984.7 5987.6 5991.9 5994.9 6123.4 6131.6 6134.1 6135.6 6194.4 5927.5 5993.9 6008.2 6011.9 6030.1 02:47:46 INFO - PROCESS | 8817 | 02:47:46 INFO - PROCESS | 8817 | [#5] yui.html Cycles:180 Average:20904.37 Median:4452.42 stddev:29030.82 (652.0%) stddev-sans-first:29072.91 02:47:46 INFO - PROCESS | 8817 | Values: 775.5 811.5 814.5 870.9 874.1 15372.0 16318.8 16672.2 17325.9 17700.9 15984.3 16031.4 16099.1 16100.9 16160.2 869.7 896.9 908.1 915.2 916.3 902.1 906.1 909.0 911.9 912.2 943.0 949.1 951.3 955.7 956.1 936.1 941.6 942.5 947.5 947.7 694.4 695.1 695.8 697.0 698.5 16142.6 16276.1 16284.0 16308.2 16330.6 15705.2 16097.6 16189.8 16208.8 16215.8 12971.2 12996.4 13291.6 13466.6 13539.0 4004.7 4143.4 4161.9 4172.1 4216.2 78133.0 78450.6 79118.0 79607.6 80193.2 12368.8 12374.7 12454.3 12499.1 12535.3 21955.0 21955.9 22189.4 22196.6 22816.3 8947.1 8975.5 9055.0 9112.9 9303.0 4969.9 5068.1 5215.7 5286.2 5346.7 3779.5 3890.0 3954.9 3966.3 3970.5 694.6 705.5 707.7 712.3 714.7 639.6 648.6 760.3 787.6 792.2 10787.9 11046.7 11050.6 11366.8 11403.9 677.8 720.1 777.4 817.8 822.8 4688.6 4739.2 4751.8 4788.3 4882.7 72049.6 103459.0 117893.4 118812.0 120176.4 70420.9 70951.6 96592.5 102470.5 102752.5 85765.0 86102.0 86716.0 87123.0 87809.6 9563.0 9620.6 9629.8 9832.4 9871.8 53567.5 54516.5 55354.7 56395.4 57008.0 72601.6 74127.6 76810.0 77553.2 80504.2 12599.8 12641.0 12682.2 12712.0 12879.2 13697.9 14533.6 14863.2 15098.9 15239.5 13078.3 13085.3 13202.5 13548.0 13752.2 13380.8 13998.7 14106.8 14150.6 14249.4 13596.5 13735.7 13914.8 13943.3 14070.7 11084.9 11407.3 11494.3 11578.1 11644.9 11405.5 11538.1 11566.7 11657.8 11790.4 02:47:46 INFO - PROCESS | 8817 | -------- Summary: end -------- 02:47:46 INFO - PROCESS | 8817 | 02:47:47 INFO - TEST-INFO | 8817: exit 0 02:47:47 INFO - TEST-OK | dromaeo_css | took 1110249ms 02:47:47 INFO - TEST-START | kraken 02:47:47 INFO - operating with platform_type : linux_ 02:47:47 INFO - Initialising browser for kraken test... 02:47:47 INFO - TEST-INFO | started process 9061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1iyp0O/profile http://localhost:41189/getInfo.html) 02:47:51 INFO - PROCESS | 9061 | __metrics Screen width/height:1600/1200 02:47:51 INFO - PROCESS | 9061 | colorDepth:24 02:47:51 INFO - PROCESS | 9061 | Browser inner width/height: 1024/697 02:47:51 INFO - PROCESS | 9061 | __metrics 02:47:52 ERROR - PROCESS | 9061 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 02:47:53 INFO - TEST-INFO | 9061: exit 0 02:47:53 INFO - Browser initialized. 02:47:53 INFO - Running cycle 1/1 for kraken test... 02:47:53 INFO - TEST-INFO | started process 9193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1iyp0O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:05 INFO - PROCESS | 9193 | RSS: Main: 161075200 02:49:05 INFO - PROCESS | 9193 | 02:49:22 INFO - PROCESS | 9193 | 1465292962805 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:49:33 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41189/tests/kraken/driver.html?testName=audio-beat-detection) 02:49:34 INFO - PROCESS | 9193 | RSS: Main: 157274112 02:49:34 INFO - PROCESS | 9193 | 02:49:36 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41189/tests/kraken/driver.html?testName=audio-dft) 02:49:37 INFO - PROCESS | 9193 | RSS: Main: 158220288 02:49:37 INFO - PROCESS | 9193 | 02:49:40 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41189/tests/kraken/driver.html?testName=audio-fft) 02:49:40 INFO - PROCESS | 9193 | RSS: Main: 158887936 02:49:40 INFO - PROCESS | 9193 | 02:49:42 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41189/tests/kraken/driver.html?testName=audio-oscillator) 02:49:43 INFO - PROCESS | 9193 | RSS: Main: 158621696 02:49:43 INFO - PROCESS | 9193 | 02:49:45 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41189/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:49:46 INFO - PROCESS | 9193 | RSS: Main: 159055872 02:49:46 INFO - PROCESS | 9193 | 02:49:49 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41189/tests/kraken/driver.html?testName=imaging-darkroom) 02:49:50 INFO - PROCESS | 9193 | RSS: Main: 159031296 02:49:50 INFO - PROCESS | 9193 | 02:49:53 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41189/tests/kraken/driver.html?testName=imaging-desaturate) 02:49:54 INFO - PROCESS | 9193 | RSS: Main: 161140736 02:49:54 INFO - PROCESS | 9193 | 02:49:56 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41189/tests/kraken/driver.html?testName=json-parse-financial) 02:49:57 INFO - PROCESS | 9193 | RSS: Main: 161705984 02:49:57 INFO - PROCESS | 9193 | 02:50:02 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41189/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:50:03 INFO - PROCESS | 9193 | RSS: Main: 157921280 02:50:03 INFO - PROCESS | 9193 | 02:50:05 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41189/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:50:05 INFO - PROCESS | 9193 | RSS: Main: 159014912 02:50:05 INFO - PROCESS | 9193 | 02:50:07 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41189/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:50:08 INFO - PROCESS | 9193 | RSS: Main: 159698944 02:50:08 INFO - PROCESS | 9193 | 02:50:11 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:50:11 INFO - PROCESS | 9193 | RSS: Main: 160129024 02:50:11 INFO - PROCESS | 9193 | 02:50:14 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:50:15 INFO - PROCESS | 9193 | RSS: Main: 159744000 02:50:15 INFO - PROCESS | 9193 | 02:50:16 INFO - PROCESS | 9193 | Cycle 1(1): loaded http://localhost:41189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41189/tests/kraken/driver.html?testName=ai-astar) 02:50:16 INFO - PROCESS | 9193 | RSS: Main: 160829440 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | __start_tp_report 02:50:17 INFO - PROCESS | 9193 | _x_x_mozilla_page_load 02:50:17 INFO - PROCESS | 9193 | _x_x_mozilla_page_load_details 02:50:17 INFO - PROCESS | 9193 | |i|pagename|runs| 02:50:17 INFO - PROCESS | 9193 | |0;ai-astar;111;112;103;109;112;111;110;111;110;110 02:50:17 INFO - PROCESS | 9193 | |1;audio-beat-detection;147;123;151;173;126;152;152;128;185;127 02:50:17 INFO - PROCESS | 9193 | |2;audio-dft;161;163;161;162;169;161;162;162;163;163 02:50:17 INFO - PROCESS | 9193 | |3;audio-fft;75;74;76;173;76;76;74;76;172;82 02:50:17 INFO - PROCESS | 9193 | |4;audio-oscillator;96;98;153;84;84;85;135;83;84;149 02:50:17 INFO - PROCESS | 9193 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;117;117 02:50:17 INFO - PROCESS | 9193 | |6;imaging-darkroom;145;146;146;146;145;147;146;146;146;147 02:50:17 INFO - PROCESS | 9193 | |7;imaging-desaturate;95;95;95;95;94;96;99;95;95;95 02:50:17 INFO - PROCESS | 9193 | |8;json-parse-financial;53;53;57;53;55;67;56;54;62;60 02:50:17 INFO - PROCESS | 9193 | |9;json-stringify-tinderbox;60;59;60;60;60;58;59;60;60;60 02:50:17 INFO - PROCESS | 9193 | |10;stanford-crypto-aes;76;76;75;76;78;77;77;77;77;82 02:50:17 INFO - PROCESS | 9193 | |11;stanford-crypto-ccm;125;134;117;127;127;116;115;114;148;116 02:50:17 INFO - PROCESS | 9193 | |12;stanford-crypto-pbkdf2;158;156;154;156;154;153;156;151;152;152 02:50:17 INFO - PROCESS | 9193 | |13;stanford-crypto-sha256-iterative;65;68;70;65;64;64;67;63;63;63 02:50:17 INFO - PROCESS | 9193 | __end_tp_report 02:50:17 INFO - PROCESS | 9193 | __start_cc_report 02:50:17 INFO - PROCESS | 9193 | _x_x_mozilla_cycle_collect,865 02:50:17 INFO - PROCESS | 9193 | __end_cc_report 02:50:17 INFO - PROCESS | 9193 | __startTimestamp1465293017001__endTimestamp 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | ------- Summary: start ------- 02:50:17 INFO - PROCESS | 9193 | Number of tests: 14 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.60 (2.3%) stddev-sans-first:2.73 02:50:17 INFO - PROCESS | 9193 | Values: 111.0 112.0 103.0 109.0 112.0 111.0 110.0 111.0 110.0 110.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:151.50 stddev:20.98 (13.8%) stddev-sans-first:22.25 02:50:17 INFO - PROCESS | 9193 | Values: 147.0 123.0 151.0 173.0 126.0 152.0 152.0 128.0 185.0 127.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:2.36 (1.5%) stddev-sans-first:2.42 02:50:17 INFO - PROCESS | 9193 | Values: 161.0 163.0 161.0 162.0 169.0 161.0 162.0 162.0 163.0 163.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.00 stddev:40.70 (53.5%) stddev-sans-first:42.49 02:50:17 INFO - PROCESS | 9193 | Values: 75.0 74.0 76.0 173.0 76.0 76.0 74.0 76.0 172.0 82.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:84.00 stddev:28.82 (34.3%) stddev-sans-first:30.38 02:50:17 INFO - PROCESS | 9193 | Values: 96.0 98.0 153.0 84.0 84.0 85.0 135.0 83.0 84.0 149.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:50:17 INFO - PROCESS | 9193 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 02:50:17 INFO - PROCESS | 9193 | Values: 145.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 147.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 02:50:17 INFO - PROCESS | 9193 | Values: 95.0 95.0 95.0 95.0 94.0 96.0 99.0 95.0 95.0 95.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:4.67 (8.3%) stddev-sans-first:4.72 02:50:17 INFO - PROCESS | 9193 | Values: 53.0 53.0 57.0 53.0 55.0 67.0 56.0 54.0 62.0 60.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 02:50:17 INFO - PROCESS | 9193 | Values: 60.0 59.0 60.0 60.0 60.0 58.0 59.0 60.0 60.0 60.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.00 stddev:1.91 (2.5%) stddev-sans-first:1.99 02:50:17 INFO - PROCESS | 9193 | Values: 76.0 76.0 75.0 76.0 78.0 77.0 77.0 77.0 77.0 82.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:126.00 stddev:10.82 (8.6%) stddev-sans-first:11.46 02:50:17 INFO - PROCESS | 9193 | Values: 125.0 134.0 117.0 127.0 127.0 116.0 115.0 114.0 148.0 116.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:155.00 stddev:2.25 (1.5%) stddev-sans-first:1.92 02:50:17 INFO - PROCESS | 9193 | Values: 158.0 156.0 154.0 156.0 154.0 153.0 156.0 151.0 152.0 152.0 02:50:17 INFO - PROCESS | 9193 | 02:50:17 INFO - PROCESS | 9193 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:2.39 (3.7%) stddev-sans-first:2.54 02:50:17 INFO - PROCESS | 9193 | Values: 65.0 68.0 70.0 65.0 64.0 64.0 67.0 63.0 63.0 63.0 02:50:17 INFO - PROCESS | 9193 | -------- Summary: end -------- 02:50:17 INFO - PROCESS | 9193 | 02:50:21 INFO - TEST-INFO | 9193: exit 0 02:50:21 INFO - TEST-OK | kraken | took 154016ms 02:50:21 INFO - SUITE-END | took 1264s 02:50:21 INFO - Completed test suite (00:21:04) 02:50:21 INFO - javascript benchmark 02:50:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7737.179563592932, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3388.88138915138, 3416.5046068320103, 3435.433153529668, 3440.5355277037625, 3466.705330046946, 5804.59367844251, 5805.796797112102, 5819.447152520509, 5837.649741015542, 5901.05583106703, 5818.272715910512, 5866.76532938682, 5872.7944521941745, 5913.083472061827, 5921.585489015771, 5229.372475302969, 5296.470352964711, 5318.6011049171275, 5353.384360798519, 5355.7857685692525, 5221.843344699665, 5244.580433565325, 5309.522143007129, 5355.973220133894, 5376.542993845528, 5294.232336311233, 5303.867403314909, 5324.7071411072375, 5333.893322133555, 5340.706261155635, 5392.973035134819, 5400.513953744143, 5401.459854014606, 5419.864503387407, 5420.24116623671, 5098.643094983353, 5155.226715992631, 5202.92195617066, 5306.389765176977, 5314.840554783363, 5604.3835178130375, 5633.943660563424, 5657.745401456944, 5683.232763576905, 5695.77216911323, 6133.325334213233, 6164.660943648098, 6170.7223174957235, 6171.796499682564, 6187.597806142587, 5991.071383935497, 6202.658853763041, 6212.565120441571, 6276.560640755149, 6283.246010478726, 5886.941130588682, 5890.087036509348, 5892.204552385416, 5925.792597259076, 5954.583179177459, 6357.6145727339945, 6386.776462823779, 6406.775762848278, 6409.102725618417, 6418.133551970424, 6015.1278064681255, 6108.3280839107665, 6111.04482360895, 6127.754889804358, 6220.03589443637, 6311.463525600284, 6335.809925702236, 6339.175907132043, 6341.3341599132345, 6344.777932772423, 5908.172855800191, 6270.968645156836, 6336.144620476269, 6337.556371053982, 6342.619442833353, 6147.323794382614, 6159.0, 6187.0, 6290.496760259169, 6333.2716737575765, 4657.417822772153, 4776.402949631296, 4783.5933945614315, 4806.44725856524, 4811.518848115161, 4187.560306167869, 4207.053412982054, 4250.0, 4258.7657678827345, 4270.274053410865, 5777.508911742465, 5909.349971503131, 5945.4649081582, 6051.636901785907, 6074.574779765374, 6214.728697628956, 6254.2807577129215, 6277.780277690259, 6283.277423096311, 6284.685765711696, 5759.481646651821, 5853.560982926298, 5995.190649262294, 6009.579329446897, 6015.218021657244, 5414.133738601805, 5415.241866138744, 5435.347758268954, 5452.536534394541, 5461.890762184734, 6539.869202615921, 6585.045168450548, 6598.340165983459, 6609.5373323867825, 6632.767853125118, 6085.908711369421, 6139.9079013813935, 6301.243850737941, 6362.491000719839, 6367.522435817332, 6326.177596912372, 6443.452306553995, 6453.128827608401, 6459.806205813833, 6471.935280647133, 6055.969720151371, 6106.206193195034, 6108.419700128481, 6123.357047509948, 6130.2030736004035, 6046.0, 6208.689565521616, 6231.096491008688, 6236.844078898064, 6254.155024267943, 6153.723082461211, 6178.876422471435, 6187.535934804998, 6189.6286222826775, 6192.0, 6130.877382452237, 6145.569810113249, 6148.815535533941, 6168.0, 6178.382161783786, 5791.305043394819, 5927.0, 5955.0, 6012.518998480024, 6037.426444487766, 6168.962067403751, 6173.876522469615, 6213.844653883689, 6220.0, 6220.7511699531515, 6075.668877543261, 6079.179310792986, 6090.725917333819, 6102.084687296941, 6120.632762034292], "value": 5763.457935309156, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.4341432225063, 646.7316063833509, 652.9738810447583, 659.2221179008768, 673.0039541478611, 46755.76622116893, 48391.75804120983, 48420.2736958945, 51966.0, 52195.478045219534, 46662.53337466624, 46824.53175468253, 47213.0, 47441.76279118608, 47570.76214618931, 9040.593173307185, 9195.816083678323, 9235.307351948597, 9241.630334786634, 9250.213731832802, 9186.54067296636, 9236.168744812965, 9292.628294868196, 9293.0, 9308.720738377859, 9112.362134650577, 9309.208717259042, 9332.813343733154, 9350.485723285217, 9364.625414983426, 9250.121238482334, 9299.209567186763, 9305.860412093823, 9307.11582399671, 9318.72043838686, 9003.324750643727, 9127.087291270886, 9128.224100951427, 9140.817183656356, 9145.314101442353, 46669.53330466686, 46699.0, 47000.0, 47005.0, 47084.293735593994, 3743.401055831054, 3778.1688028633657, 3827.4067519534515, 3909.5113110861143, 4462.152191083716, 35132.121696957525, 35355.64644353575, 35357.4696379552, 35670.46494302587, 36764.0, 4672.392588963413, 4783.952160478386, 4806.303086052503, 4808.3027960945465, 4832.275158726184, 384701.0, 388632.0, 389575.99999999715, 390863.0, 391549.0, 38832.22335553273, 69096.6545167281, 69231.30768692249, 69509.21963121419, 70011.2998870015, 40830.38754418686, 40879.591204088174, 40915.0, 40951.59048409478, 41186.58813411887, 16070.75893861593, 16073.437429690139, 16107.355705771637, 16172.83827161737, 16211.351545938267, 13943.511977080754, 14000.859991400159, 14051.297435128203, 14117.43530258778, 14265.42938282457, 9356.34505584616, 9359.532023398802, 9376.671816486527, 9465.90534094664, 9469.715908522618, 3568.4647302904773, 3632.164602141522, 3643.8178091095338, 3655.597884232732, 3668.669819716238, 1051.4374809477047, 1114.3578822247664, 1115.6764538283808, 1115.8214685650419, 1168.6318809574957, 33723.49414758781, 33951.830240848634, 34264.828675856465, 34964.0, 34978.125546861535, 1168.4041139019162, 1192.5945178639304, 1244.9604580175474, 1253.674044748372, 1306.137948953686, 17974.0, 18111.45665630033, 18285.725714114298, 18344.266229350676, 18411.63176736458, 625989.0, 636258.0, 658165.0, 658783.0, 659857.0, 63896.68051659712, 69820.0, 70194.2980570198, 70715.0, 70932.64533677402, 1447.7973083768281, 1481.9851801481848, 1483.9777403338958, 1501.5570406730042, 1512.1456377146876, 33893.66106338905, 35422.822885885405, 35625.109372264866, 35816.82091589525, 36093.819530902176, 60851.39148608457, 61229.38770612237, 61325.38674613197, 61365.386346135965, 61438.0, 561592.0, 564092.0, 565281.0, 565595.0, 567764.0, 50586.24120638267, 50901.98196036133, 51327.230091549405, 52126.478735212164, 52391.47608524018, 55393.0, 55819.16271256016, 56276.0, 56326.155107672595, 56617.15074273807, 45269.56617122789, 45854.0, 45949.770251149865, 46816.7659161702, 47514.0, 44865.0, 45303.77348113238, 45490.77254613706, 45995.540044600464, 46748.7662561685, 45779.31331029971, 46348.0, 46789.064218716114, 47050.29424558566, 47090.76454617705, 39883.60116398799, 40050.79974600225, 40177.99110044545, 40781.1843763129, 41955.37066944059, 30461.390772184874, 30658.233544161576, 30943.226419339695, 31145.0, 31151.0], "value": 21263.28170420642, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.76632235431686, 430.4812700695661, 431.9591390003648, 435.449156816627, 435.9782010899454, 19148.521286967833, 20684.689729654066, 21040.579188416243, 22108.22621208258, 22159.44601384966, 19585.706214406797, 19860.60278794427, 21015.47461313468, 21108.472288192803, 21141.788582114175, 5756.194132821408, 5950.9107363389585, 5955.940440595582, 5982.581219314649, 5988.580799344048, 5805.622634528763, 5832.558790313714, 5901.49837263831, 5924.703764811742, 5940.613860099102, 5774.913376299359, 5842.824715258528, 5848.1812546243345, 5869.618474799146, 5879.0, 5491.533219676332, 5824.301083869942, 5841.8831623367505, 5853.619514731571, 5933.050711886078, 5589.245451863987, 5697.0, 5743.253377060997, 5813.128030795372, 5825.533957283407, 14809.407623695039, 15003.32485038176, 15339.846601533953, 24966.750332496624, 25068.874655626605, 2408.506256217471, 2417.492326611414, 2440.1825388494876, 2491.314888405685, 2516.6854143232094, 10972.451377431096, 11016.11871050322, 11115.777684446266, 11127.0, 11151.498182581803, 1886.8584856135844, 2014.1842553765748, 2044.6626306659384, 2089.6238677038127, 2095.2666566701687, 70196.0, 88257.0, 90472.54763726205, 91124.54437727769, 92282.53858730731, 10833.349999000086, 10847.132229421784, 10959.232853700165, 11071.391073491035, 11815.11386646005, 14553.345099470549, 14636.634084147769, 14672.266386680623, 14799.92600036993, 14826.925865370604, 8761.605727742266, 8849.51327676971, 8880.289576833839, 8906.421082629608, 9071.59177836999, 8728.694495692747, 8758.824823503493, 8820.33847461443, 8822.073682263399, 8831.337649676172, 4631.328457373662, 4632.698874573142, 4723.173444647173, 4723.551262630113, 4810.062037902575, 2065.8037486439066, 2089.9268525601533, 2114.1649048626014, 2119.9258025969016, 2136.903839327234, 458.40407470288494, 940.5908429833045, 993.6323560282742, 1080.6271836216492, 1136.1933027550367, 11973.16187866841, 12072.637820865388, 12730.98152147826, 13080.738385232242, 13133.277669728257, 491.26555799079887, 496.92546118081856, 497.45280191789465, 502.2892606961109, 505.8608882557253, 6793.252742198354, 6984.126984126984, 7083.858322833515, 7084.610346430893, 7143.464240182007, 501646.0, 508330.0, 513162.0, 549527.0, 563561.0, 82030.0, 86792.56603716941, 93825.5308723452, 93828.0, 112806.0, 1099.0493223361734, 1120.8767035626074, 1126.633844000703, 1127.1546340244815, 1132.388510204497, 18597.81402185961, 18598.81401186025, 18606.0, 18636.254549817855, 18927.810721892605, 43698.34452483279, 44632.55367446284, 44776.328355074045, 45185.0, 45611.77194114008, 60410.39589604048, 61553.38446615476, 64927.0, 65298.347016529224, 66694.33305666881, 9110.544472776468, 9160.58777355034, 9167.312451566026, 9299.67451139207, 9344.252459803063, 12378.504859805867, 14011.719765604426, 14201.715965680834, 14260.358283877044, 14275.785863212268, 12089.214201076902, 12229.266244025386, 12240.632781016584, 12591.181573197713, 12834.0, 11905.642830715093, 11997.40012999364, 12293.75412491763, 12402.503899844267, 12553.874461255637, 12400.069994750611, 12577.496900124259, 12604.810927836274, 12689.0, 12797.552085676956, 9240.0, 9267.0, 9309.581068852054, 9341.252699783865, 9380.3902746324, 9612.086851749073, 11654.53381864716, 12038.217515861441, 12731.745365092831, 13163.078584498993], "value": 9186.129726150748, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1567.7491601343784, 1580.044073335632, 1812.5378028602704, 1897.9430617081493, 1905.361703829218, 9353.204977576906, 9617.615295388176, 9673.661421850236, 9770.218382529398, 10048.748781280472, 9723.902760972389, 9791.755206119851, 9884.604615815359, 9911.355761875473, 9969.10278074973, 2524.558202314592, 2547.6942766868, 2549.8725063746833, 2550.387906902339, 2563.2566555698827, 2493.7132229793624, 2532.5947848344267, 2550.183941138827, 2554.7572980566815, 2557.897684092634, 2445.7187423446267, 2467.580511313081, 2481.2184161988916, 2482.441450673593, 2486.813488988333, 2416.347586151738, 2430.1130087518104, 2457.1154384421593, 2461.88921498533, 2467.4324905271887, 2413.818963577721, 2442.8778561072054, 2443.9511209775706, 2469.530789150074, 2477.380654836291, 9825.213982881352, 9908.801823963553, 9971.700848974542, 9975.700728978143, 10030.197584193247, 5736.541076713853, 5919.911201331984, 5920.437558431942, 5920.526357891358, 5921.993261145615, 3782.527184101987, 3877.011362102674, 3897.2400381925536, 3923.470331505239, 3969.2458432897656, 1213.993930030353, 1240.7084335181225, 1250.0749445410331, 1255.579380907397, 1282.724214293922, 13905.513307034205, 14203.573892783234, 14208.786868196985, 14211.147331160164, 14376.784348234889, 4884.462709101996, 4923.384576927884, 4946.035523073038, 4975.129352363322, 5031.144705400091, 10686.51910664022, 10718.517666705016, 10783.299085559414, 10784.78430431387, 10819.404932728776, 5789.8552536186935, 5885.882282354329, 5895.911561326584, 5897.705114744245, 5898.911516327258, 4599.126166028444, 5301.734913254322, 5411.83764487066, 5426.538744206708, 5472.288602481732, 4153.086321009373, 4187.937180942288, 4223.831046758157, 4230.407742915994, 4242.851500197478, 1221.6212973978095, 1227.3065717869374, 1232.8212409200617, 1236.8763123687559, 1254.084518301645, 912.2428384440898, 950.5247376311844, 1098.2696506822874, 1112.7551938573502, 1141.9257748246337, 6608.86782264352, 6812.1144251248015, 6864.931350686529, 6916.412104971134, 7107.182673992454, 1054.8681414823147, 1068.433730123036, 1076.3918386111823, 1103.2222283290262, 1106.0985296982933, 4461.219286624828, 4698.436187657435, 4722.95277047232, 4738.431388233434, 4791.257355109963, 11925.403729813648, 12288.508459661693, 12301.384930753427, 12711.682207944876, 12810.615681529569, 12491.875081249253, 12649.557265495663, 12659.810102848465, 12682.746345073047, 12706.618801435972, 9111.863322050174, 9267.25861931044, 9268.860967085498, 9316.813663726687, 9324.766880828034, 6856.348646878539, 6953.269906659728, 6977.651117444209, 7047.224805271314, 7069.081019467436, 11381.54473821038, 11690.064794816564, 11792.705182370166, 11886.0, 11944.522219111139, 11753.471093800628, 11902.523899044287, 11912.40437978115, 12030.819537706766, 12066.034717222425, 8135.83728325442, 8464.153584641486, 8778.604962776562, 8823.117688231125, 9011.324150688593, 9709.805803884024, 9734.513274336396, 9752.073553012453, 9760.170385517311, 9765.414075155513, 8534.70128545498, 8718.17177368149, 8815.823683526165, 8828.514431706319, 8849.159329863653, 8503.74488765338, 8524.445911015764, 8770.91229087701, 8777.605007774539, 8955.731328060168, 7901.565413902291, 7915.802104947423, 7938.761837144895, 7939.761807145795, 7964.800879978047, 5702.800401985911, 5772.365039845529, 5803.7968671096305, 5816.476517113311, 5874.03078492044, 5843.620164689281, 5851.824445266649, 5877.500412464989, 5923.555733319932, 5963.612365196422], "value": 5172.597110776642, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.2861134813352, 361.0684434159868, 365.73301489912365, 366.21446996193174, 368.7437231124366, 5639.351474580424, 5756.222909907161, 5763.221965034719, 5833.824985250444, 5857.619254748443, 5772.480476757091, 5802.39074897136, 5829.533637309016, 5837.883242335161, 5841.561882858781, 4418.624416924566, 4467.173572889026, 4485.932711009321, 4486.237339652267, 4489.0, 4437.826953728084, 4497.910041799162, 4511.548845115479, 4517.1417430688225, 4520.660950428714, 4425.911481770363, 4463.754493502856, 4472.485664148616, 4482.798274077674, 4487.842925497608, 4437.5340589237985, 4452.376667266585, 4460.197164510387, 4483.820647174109, 4488.192125417424, 3917.823697933571, 3965.206958608261, 3974.085960229135, 3998.140399814054, 4050.41269015991, 5568.6658800472105, 5597.7201139943245, 5605.943940560583, 5630.774769009235, 5644.774209031634, 5144.0740666679985, 5153.536181743623, 5161.354830646169, 5178.818741344035, 5211.5049070338255, 5821.50517206038, 6059.818205453844, 6094.8781024379705, 6099.0, 6112.266528016667, 4407.0, 4422.093470838503, 4422.7346359218545, 4425.159219748238, 4426.955730442719, 6088.96955515224, 6206.782762603287, 6220.409061139185, 6291.307956124822, 6301.779437719658, 4393.582609652142, 4477.895389167086, 4483.417155769729, 4489.361383095212, 4489.820407183742, 4507.278835386388, 4532.388127602798, 4536.432945881765, 4537.251353526697, 4588.453408358327, 5146.150885103991, 5188.169892817131, 5210.166373380241, 5213.7393130343335, 5245.186996015624, 5758.395368486333, 5920.437558431942, 5962.07587823888, 6107.175531303217, 6126.785562505291, 1565.0375019363237, 1580.146720770794, 1586.8175159856532, 1589.4675283780064, 1589.6105454163803, 1015.6140666546813, 1019.6125472320471, 1021.4739409204266, 1037.8028174646793, 1048.6853943816825, 5197.934423443185, 5249.580033597303, 5260.947810437928, 5262.842234683838, 5291.814786482455, 5546.722663866791, 5549.916751248735, 5587.658961849208, 5590.5248053915875, 5647.519960803295, 5319.547838433699, 5323.642471169827, 5591.916121258185, 5970.0, 6058.4244496772735, 3306.983465082659, 3335.766496345281, 3372.6458721834347, 3386.508956201337, 3415.8121303328558, 6188.412100850412, 6518.967405163039, 6541.28045914949, 6552.967235163889, 6582.058292803538, 6333.46165575922, 6416.7433302668305, 6422.42198202164, 6434.710438030206, 6452.6451045192025, 6362.745490180341, 6448.645324507103, 6468.477293855401, 6474.1907261592305, 6513.576617519846, 6188.81433556994, 6225.0, 6225.595336303126, 6258.374162583706, 6332.651704156316, 6010.579259451796, 6152.600080994721, 6202.81391558254, 6212.384779957153, 6212.695333979915, 6295.937040629535, 6451.387153211697, 6480.287168411377, 6532.869342613026, 6539.411452969065, 4408.779561022, 4426.933595996127, 4453.421055262925, 4453.977730111329, 4459.509453960127, 5959.418912094019, 6293.804177206316, 6364.427201551883, 6371.39471750183, 6393.808185754435, 6120.785772497941, 6162.845928851635, 6168.563417450172, 6171.59884607499, 6178.980468222693, 6050.576459647782, 6126.540509461897, 6131.63210207389, 6132.2947860996555, 6149.200603921461, 5877.795052014412, 5984.730687119003, 5987.64074155552, 5991.880162396815, 5994.910076348771, 6123.387661233841, 6131.601445906002, 6134.141220229082, 6135.601185922901, 6194.4115309045565, 5927.4665280125, 5993.940060599512, 6008.188894499187, 6011.909821352596, 6030.10051833671], "value": 4617.0254255941645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.5075527040332, 811.5333683132201, 814.4543156085422, 870.9390342676011, 874.147705986663, 15372.0, 16318.83681163188, 16672.16639168043, 17325.913370433147, 17700.91149544252, 15984.280707368167, 16031.438899638515, 16099.114548699818, 16100.919495402535, 16160.191990400492, 869.6608322754131, 896.932730045246, 908.1236606674557, 915.2129168914728, 916.2852974679761, 902.1429641840245, 906.1029580715077, 909.0, 911.9361644684875, 912.2200518556638, 942.9811403771955, 949.0746522140892, 951.3198063384679, 955.7276176289758, 956.1394744729764, 936.091990768953, 941.6092321686526, 942.5428667096453, 947.5499137909507, 947.70147403568, 694.437505620444, 695.1102588686439, 695.7808290388562, 696.958182509046, 698.4866123399297, 16142.6278766305, 16276.104814235212, 16284.0, 16308.184590770414, 16330.591735206715, 15705.164889302483, 16097.597560060975, 16189.83810161895, 16208.83791162085, 16215.756763648555, 12971.156874803202, 12996.41516131767, 13291.601251962456, 13466.596002119952, 13539.0, 4004.739691920016, 4143.4199212110325, 4161.875143745692, 4172.123853990665, 4216.198922204771, 78133.0, 78450.60774696147, 79118.0, 79607.60196198981, 80193.19806801916, 12368.75262494745, 12374.690632734073, 12454.31501267439, 12499.062570307264, 12535.31055791922, 21955.0, 21955.890220549114, 22189.44526386821, 22196.556068878534, 22816.31551053471, 8947.10528947113, 8975.461472311683, 9054.954725226331, 9112.908870911338, 9302.95348523253, 4969.900601988013, 5068.087744206005, 5215.713135777492, 5286.207068939613, 5346.732663366816, 3779.508663873679, 3890.0, 3954.9011274718364, 3966.345552983783, 3970.5235371755575, 694.5520139509988, 705.544923524324, 707.678006507038, 712.2734810493267, 714.731975509184, 639.5778786001217, 648.5687018132888, 760.2967255288836, 787.6180052674448, 792.2315354106507, 10787.892121078845, 11046.668599942015, 11050.613228536962, 11366.829497557543, 11403.885961140282, 677.8203775999364, 720.121451828768, 777.3690420711341, 817.7996390884152, 822.7655118291258, 4688.64835137366, 4739.218029025241, 4751.809927602926, 4788.266948877537, 4882.707037577757, 72049.6397518009, 103459.0, 117893.41053294679, 118812.0, 120176.3991180056, 70420.94368584476, 70951.64524177345, 96592.51703741436, 102470.48764756278, 102752.48623756833, 85765.0, 86102.0, 86716.0, 87123.0, 87809.56095219484, 9563.0, 9620.567074481525, 9629.807403852024, 9832.38439313574, 9871.802563948537, 53567.464325356246, 54516.454835451135, 55354.72322638361, 56395.43604563902, 57008.0, 72601.6369918147, 74127.62936185284, 76810.0, 77553.22446775685, 80504.19495804967, 12599.811002834782, 12640.98872090249, 12682.239065656091, 12712.0, 12879.227246365248, 13697.931510342385, 14533.563993080224, 14863.18252496123, 15098.924505377403, 15239.466618668293, 13078.346082695636, 13085.280309583064, 13202.537911173064, 13548.0, 13752.243626600633, 13380.799288010883, 13998.65003374883, 14106.78839817383, 14150.646233844236, 14249.430022798972, 13596.484680192156, 13735.725285494034, 13914.791278131039, 13943.302834858014, 14070.717493930673, 11084.944575277072, 11407.315561066363, 11494.310341379543, 11578.131640127192, 11644.88355116438, 11405.486753095965, 11538.134639901873, 11566.749826956975, 11657.76684466289, 11790.351530665552], "value": 7978.852320937414, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 103.0, 109.0, 112.0, 111.0, 110.0, 111.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 151.0, 173.0, 126.0, 152.0, 152.0, 128.0, 185.0, 127.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 162.0, 169.0, 161.0, 162.0, 162.0, 163.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 173.0, 76.0, 76.0, 74.0, 76.0, 172.0, 82.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 153.0, 84.0, 84.0, 85.0, 135.0, 83.0, 84.0, 149.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 99.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 57.0, 53.0, 55.0, 67.0, 56.0, 54.0, 62.0, 60.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 60.0, 60.0, 58.0, 59.0, 60.0, 60.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 76.0, 78.0, 77.0, 77.0, 77.0, 77.0, 82.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 134.0, 117.0, 127.0, 127.0, 116.0, 115.0, 114.0, 148.0, 116.0], "value": 123.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 154.0, 156.0, 154.0, 153.0, 156.0, 151.0, 152.0, 152.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 70.0, 65.0, 64.0, 64.0, 67.0, 63.0, 63.0, 63.0], "value": 65.2, "unit": "score"}]}]} 02:50:21 INFO - Return code: 0 02:50:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:50:21 ERROR - # TBPL SUCCESS # 02:50:21 INFO - Running post-action listener: _resource_record_post_action 02:50:21 INFO - ##### 02:50:21 INFO - ##### Finished run-tests step (success) 02:50:21 INFO - ##### 02:50:21 INFO - Running post-run listener: _resource_record_post_run 02:50:21 INFO - Total resource usage - Wall time: 1281s; CPU: 13.0%; Read bytes: 266240; Write bytes: 521695232; Read time: 40; Write time: 496180 02:50:21 INFO - TinderboxPrint: CPU usage
13.4% 02:50:21 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 40 02:50:21 INFO - TinderboxPrint: I/O write bytes / time
521,695,232 / 496,180 02:50:21 INFO - TinderboxPrint: CPU idle
8,844.3 (86.6%) 02:50:21 INFO - TinderboxPrint: CPU system
145.5 (1.4%) 02:50:21 INFO - TinderboxPrint: CPU user
1,209.1 (11.8%) 02:50:21 INFO - TinderboxPrint: Swap in / out
0 / 0 02:50:21 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 252633088; Read time: 0; Write time: 362724 02:50:21 INFO - run-tests - Wall time: 1266s; CPU: 13.0%; Read bytes: 266240; Write bytes: 268476416; Read time: 40; Write time: 133444 02:50:22 INFO - Running post-run listener: _upload_blobber_files 02:50:22 INFO - Blob upload gear active. 02:50:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:50:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:50:22 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'] 02:50:22 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 02:50:22 INFO - (blobuploader) - INFO - Open directory for files ... 02:50:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:50:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:50:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:23 INFO - (blobuploader) - INFO - Done attempting. 02:50:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:50:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:50:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:27 INFO - (blobuploader) - INFO - Done attempting. 02:50:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:50:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:50:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:28 INFO - (blobuploader) - INFO - Done attempting. 02:50:28 INFO - (blobuploader) - INFO - Iteration through files over. 02:50:28 INFO - Return code: 0 02:50:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:50:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:50:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fc6410da21f4dd001d3f72fbd9b75c814a118b809b4647714488ed6ba974cf8c18e4c7a0eae5712aacb5c0e5021a770f515c82a88e38eafbf3c54dda24cb112", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/650b7b1222f7ad7d457560326d9c576456eed755f549a83ff63aab30d3e9b6031e7dbe6de20f903a2421a36ba24bd89348ca9600cb631eadfd565741eaf9dac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc3ee0686d65603a6af2bf9ff0e85de6588f7cef94b24862ed78f439fa2fc0450e721075c2baea40d83177b91b653de2966435afd2bd7273e45df7acac7aa560"} 02:50:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:50:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:50:28 INFO - Contents: 02:50:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fc6410da21f4dd001d3f72fbd9b75c814a118b809b4647714488ed6ba974cf8c18e4c7a0eae5712aacb5c0e5021a770f515c82a88e38eafbf3c54dda24cb112", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/650b7b1222f7ad7d457560326d9c576456eed755f549a83ff63aab30d3e9b6031e7dbe6de20f903a2421a36ba24bd89348ca9600cb631eadfd565741eaf9dac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc3ee0686d65603a6af2bf9ff0e85de6588f7cef94b24862ed78f439fa2fc0450e721075c2baea40d83177b91b653de2966435afd2bd7273e45df7acac7aa560"} 02:50:28 INFO - Running post-run listener: copy_logs_to_upload_dir 02:50:28 INFO - Copying logs to upload dir... 02:50:28 INFO - mkdir: /builds/slave/test/build/upload/logs 02:50:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1323.955161 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2016-06-07 02:50:27.988854) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:50:27.992940) ========= 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=db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fc6410da21f4dd001d3f72fbd9b75c814a118b809b4647714488ed6ba974cf8c18e4c7a0eae5712aacb5c0e5021a770f515c82a88e38eafbf3c54dda24cb112", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/650b7b1222f7ad7d457560326d9c576456eed755f549a83ff63aab30d3e9b6031e7dbe6de20f903a2421a36ba24bd89348ca9600cb631eadfd565741eaf9dac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc3ee0686d65603a6af2bf9ff0e85de6588f7cef94b24862ed78f439fa2fc0450e721075c2baea40d83177b91b653de2966435afd2bd7273e45df7acac7aa560"} build_url:https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fc6410da21f4dd001d3f72fbd9b75c814a118b809b4647714488ed6ba974cf8c18e4c7a0eae5712aacb5c0e5021a770f515c82a88e38eafbf3c54dda24cb112", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/650b7b1222f7ad7d457560326d9c576456eed755f549a83ff63aab30d3e9b6031e7dbe6de20f903a2421a36ba24bd89348ca9600cb631eadfd565741eaf9dac8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc3ee0686d65603a6af2bf9ff0e85de6588f7cef94b24862ed78f439fa2fc0450e721075c2baea40d83177b91b653de2966435afd2bd7273e45df7acac7aa560"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:50:28.017979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:50:28.018303) ========= 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=db0483c52d987ecb441a263b000001ad-1465291701.976690-1132280212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:50:28.100356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:50:28.100697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:50:28.100979) ========= ========= Total master_lag: 0.19 =========