builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1467038490.15 results: success (0) buildid: 20160627050926 builduid: 1b39fd9830024bb7bac34e00000abee1 revision: fd8d4ad885aa3adcc5d620d2a03aab15577664fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:30.148354) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:30.148841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:30.149143) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:30.167850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:30.168118) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 07:41:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.3M=0s 2016-06-27 07:41:30 (33.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:30.292797) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:30.293110) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019467 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:30.342482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:30.342851) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fd8d4ad885aa3adcc5d620d2a03aab15577664fc --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 fd8d4ad885aa3adcc5d620d2a03aab15577664fc --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=9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 07:41:30,536 truncating revision to first 12 chars 2016-06-27 07:41:30,536 Setting DEBUG logging. 2016-06-27 07:41:30,536 attempt 1/10 2016-06-27 07:41:30,537 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fd8d4ad885aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 07:41:30,845 unpacking tar archive at: mozilla-aurora-fd8d4ad885aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643515 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:31.000952) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:31.001276) ========= script_repo_revision: fd8d4ad885aa3adcc5d620d2a03aab15577664fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:31.001916) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:31.002306) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 07:41:31.012267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-27 07:41:31.012764) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:41:31 INFO - MultiFileLogger online at 20160627 07:41:31 in /builds/slave/test 07:41:31 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 07:41:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:41:31 INFO - {'append_to_log': False, 07:41:31 INFO - 'base_work_dir': '/builds/slave/test', 07:41:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:41:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:41:31 INFO - 'branch': 'Mozilla-Aurora', 07:41:31 INFO - 'buildbot_json_path': 'buildprops.json', 07:41:31 INFO - 'config_files': ('talos/linux_config.py',), 07:41:31 INFO - 'default_actions': ('clobber', 07:41:31 INFO - 'read-buildbot-config', 07:41:31 INFO - 'download-and-extract', 07:41:31 INFO - 'populate-webroot', 07:41:31 INFO - 'create-virtualenv', 07:41:31 INFO - 'install', 07:41:31 INFO - 'run-tests'), 07:41:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:41:31 INFO - 'download_minidump_stackwalk': True, 07:41:31 INFO - 'download_symbols': 'ondemand', 07:41:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:41:31 INFO - 'tooltool.py': '/tools/tooltool.py', 07:41:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:41:31 INFO - '/tools/misc-python/virtualenv.py')}, 07:41:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:41:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:41:31 INFO - 'installer_path': 'installer.exe', 07:41:31 INFO - 'log_level': 'info', 07:41:31 INFO - 'log_name': 'talos', 07:41:31 INFO - 'log_to_console': True, 07:41:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:41:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:41:31 INFO - 'opt_config_files': (), 07:41:31 INFO - 'pip_index': False, 07:41:31 INFO - 'sps_profile': False, 07:41:31 INFO - 'sps_profile_interval': 0, 07:41:31 INFO - 'suite': 'dromaeojs-e10s', 07:41:31 INFO - 'system_bits': '32', 07:41:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:41:31 INFO - 'title': 'talos-linux64-ix-013', 07:41:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:41:31 INFO - 'use_talos_json': True, 07:41:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:41:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:41:31 INFO - 'work_dir': 'build'} 07:41:31 INFO - ##### 07:41:31 INFO - ##### Running clobber step. 07:41:31 INFO - ##### 07:41:31 INFO - Running pre-action listener: _resource_record_pre_action 07:41:31 INFO - Running main action method: clobber 07:41:31 INFO - rmtree: /builds/slave/test/build 07:41:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:41:32 INFO - Running post-action listener: _resource_record_post_action 07:41:32 INFO - ##### 07:41:32 INFO - ##### Finished clobber step (success) 07:41:32 INFO - ##### 07:41:32 INFO - ##### 07:41:32 INFO - ##### Running read-buildbot-config step. 07:41:32 INFO - ##### 07:41:32 INFO - Running pre-action listener: _resource_record_pre_action 07:41:32 INFO - Running main action method: read_buildbot_config 07:41:32 INFO - Using buildbot properties: 07:41:32 INFO - { 07:41:32 INFO - "project": "", 07:41:32 INFO - "product": "firefox", 07:41:32 INFO - "script_repo_revision": "production", 07:41:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:41:32 INFO - "repository": "", 07:41:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:41:32 INFO - "buildid": "20160627050926", 07:41:32 INFO - "pgo_build": "True", 07:41:32 INFO - "basedir": "/builds/slave/test", 07:41:32 INFO - "buildnumber": 372, 07:41:32 INFO - "slavename": "talos-linux64-ix-013", 07:41:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:41:32 INFO - "platform": "ubuntu64_hw", 07:41:32 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:41:32 INFO - "branch": "mozilla-aurora", 07:41:32 INFO - "repo_path": "releases/mozilla-aurora", 07:41:32 INFO - "revision": "fd8d4ad885aa3adcc5d620d2a03aab15577664fc", 07:41:32 INFO - "stage_platform": "linux64-pgo", 07:41:32 INFO - "builduid": "1b39fd9830024bb7bac34e00000abee1", 07:41:32 INFO - "slavebuilddir": "test" 07:41:32 INFO - } 07:41:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 07:41:32 INFO - Running post-action listener: _resource_record_post_action 07:41:32 INFO - ##### 07:41:32 INFO - ##### Finished read-buildbot-config step (success) 07:41:32 INFO - ##### 07:41:32 INFO - ##### 07:41:32 INFO - ##### Running download-and-extract step. 07:41:32 INFO - ##### 07:41:32 INFO - Running pre-action listener: _resource_record_pre_action 07:41:32 INFO - Running main action method: download_and_extract 07:41:32 INFO - mkdir: /builds/slave/test/build/tests 07:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:32 INFO - https://queue.taskcluster.net/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:41:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:41:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:41:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/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 07:41:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/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 07:41:33 INFO - Downloaded 1361 bytes. 07:41:33 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:41:33 INFO - Using the following test package requirements: 07:41:33 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:41:33 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:41:33 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:41:33 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:33 INFO - u'jsshell-linux-x86_64.zip'], 07:41:33 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:41:33 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:41:33 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:41:33 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:41:33 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:41:33 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:41:33 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:33 INFO - https://queue.taskcluster.net/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:41:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:41:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:41:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/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 07:41:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/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 07:41:37 INFO - Downloaded 24522402 bytes. 07:41:37 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'] 07:41:37 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 07:41:39 INFO - Return code: 0 07:41:39 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 07:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:39 INFO - https://queue.taskcluster.net/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:41:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:41:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:41:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/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 07:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/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 07:41:40 INFO - Downloaded 24522402 bytes. 07:41:40 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'] 07:41:40 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 07:41:41 INFO - Return code: 0 07:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:41 INFO - https://queue.taskcluster.net/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:41:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:41:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:41:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/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 07:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/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 07:41:42 INFO - Downloaded 10833369 bytes. 07:41:42 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'] 07:41:42 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 07:41:43 INFO - Return code: 0 07:41: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')]} 07:41:43 INFO - https://queue.taskcluster.net/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:41:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:41:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:41:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/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 07:41:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHhHmwbsSX-cX5x6kx1GUw/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 07:41:49 INFO - Downloaded 63608742 bytes. 07:41:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:41:49 INFO - mkdir: /builds/slave/test/properties 07:41:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:41:49 INFO - Writing to file /builds/slave/test/properties/build_url 07:41:49 INFO - Contents: 07:41:49 INFO - build_url:https://queue.taskcluster.net/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:41:50 INFO - Running post-action listener: _resource_record_post_action 07:41:50 INFO - Running post-action listener: set_extra_try_arguments 07:41:50 INFO - ##### 07:41:50 INFO - ##### Finished download-and-extract step (success) 07:41:50 INFO - ##### 07:41:50 INFO - ##### 07:41:50 INFO - ##### Running populate-webroot step. 07:41:50 INFO - ##### 07:41:50 INFO - Running pre-action listener: _resource_record_pre_action 07:41:50 INFO - Running main action method: populate_webroot 07:41:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:50 INFO - '--tppagecycles', 07:41:50 INFO - '7'], 07:41:50 INFO - 'tests': ['tsvgm']}}, 07:41:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:41:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:41:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:41:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:41:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:41:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:50 INFO - 'talos_options': ['--disable-e10s'], 07:41:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:50 INFO - 'talos_options': ['--disable-e10s'], 07:41:50 INFO - 'tests': ['damp', 'tps']}, 07:41:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:50 INFO - 'tests': ['damp', 'tps']}, 07:41:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:41:50 INFO - 'tests': ['dromaeo_dom']}, 07:41:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:41:50 INFO - 'tests': ['a11yr', 07:41:50 INFO - 'ts_paint', 07:41:50 INFO - 'tpaint', 07:41:50 INFO - 'sessionrestore', 07:41:50 INFO - 'sessionrestore_no_auto_restore', 07:41:50 INFO - 'tabpaint']}, 07:41:50 INFO - 'other-e10s': {'tests': ['a11yr', 07:41:50 INFO - 'ts_paint', 07:41:50 INFO - 'tpaint', 07:41:50 INFO - 'sessionrestore', 07:41:50 INFO - 'sessionrestore_no_auto_restore', 07:41:50 INFO - 'tabpaint']}, 07:41:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:41:50 INFO - 'ts_paint', 07:41:50 INFO - 'tpaint', 07:41:50 INFO - 'sessionrestore', 07:41:50 INFO - 'sessionrestore_no_auto_restore', 07:41:50 INFO - 'tabpaint']}, 07:41:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:41:50 INFO - 'ts_paint', 07:41:50 INFO - 'tpaint', 07:41:50 INFO - 'sessionrestore', 07:41:50 INFO - 'sessionrestore_no_auto_restore', 07:41:50 INFO - 'tabpaint']}, 07:41:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:41:50 INFO - 'tests': ['a11yr', 07:41:50 INFO - 'ts_paint', 07:41:50 INFO - 'tpaint', 07:41:50 INFO - 'sessionrestore', 07:41:50 INFO - 'sessionrestore_no_auto_restore', 07:41:50 INFO - 'tabpaint']}, 07:41:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:41:50 INFO - 'tests': ['a11yr', 07:41:50 INFO - 'ts_paint', 07:41:50 INFO - 'tpaint', 07:41:50 INFO - 'sessionrestore', 07:41:50 INFO - 'sessionrestore_no_auto_restore', 07:41:50 INFO - 'tabpaint']}, 07:41:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:41:50 INFO - 'tests': ['tsvgx', 07:41:50 INFO - 'tsvgr_opacity', 07:41:50 INFO - 'tart', 07:41:50 INFO - 'tscrollx', 07:41:50 INFO - 'cart']}, 07:41:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:41:50 INFO - 'tsvgr_opacity', 07:41:50 INFO - 'tart', 07:41:50 INFO - 'tscrollx', 07:41:50 INFO - 'cart']}, 07:41:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:50 INFO - 'talos_options': ['--disable-e10s'], 07:41:50 INFO - 'tests': ['tp5o']}, 07:41:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:50 INFO - 'tests': ['tp5o']}, 07:41:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:50 INFO - 'talos_options': ['--disable-e10s', 07:41:50 INFO - '--xperf_path', 07:41:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:50 INFO - 'tests': ['tp5n']}, 07:41:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:50 INFO - 'talos_options': ['--xperf_path', 07:41:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:50 INFO - 'tests': ['tp5n']}}, 07:41:50 INFO - 'talos.zip': {'path': '', 07:41:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:50 INFO - Running post-action listener: _resource_record_post_action 07:41:50 INFO - ##### 07:41:50 INFO - ##### Finished populate-webroot step (success) 07:41:50 INFO - ##### 07:41:50 INFO - ##### 07:41:50 INFO - ##### Running create-virtualenv step. 07:41:50 INFO - ##### 07:41:50 INFO - Running pre-action listener: _resource_record_pre_action 07:41:50 INFO - Running main action method: create_virtualenv 07:41:50 INFO - Creating virtualenv /builds/slave/test/build/venv 07:41:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:41:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:41:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:50 INFO - Using real prefix '/usr' 07:41:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:41:50 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:52 INFO - Installing pip.................done. 07:41:52 INFO - Return code: 0 07:41:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:52 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 0x7fbaae4adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24381c0>, '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 0x24390c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:41:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:41:52 INFO - Using env: {'DISPLAY': ':0', 07:41:52 INFO - 'HOME': '/home/cltbld', 07:41:52 INFO - 'LANG': 'en_US.UTF-8', 07:41:52 INFO - 'LANGUAGE': 'en_US:en', 07:41:52 INFO - 'LOGNAME': 'cltbld', 07:41:52 INFO - 'MAIL': '/var/mail/cltbld', 07:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:52 INFO - 'MOZ_NO_REMOTE': '1', 07:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:52 INFO - 'NO_EM_RESTART': '1', 07:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:52 INFO - 'PWD': '/builds/slave/test', 07:41:52 INFO - 'SHELL': '/bin/bash', 07:41:52 INFO - 'SHLVL': '1', 07:41:52 INFO - 'TERM': 'linux', 07:41:52 INFO - 'TMOUT': '86400', 07:41:52 INFO - 'USER': 'cltbld', 07:41:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 07:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:52 INFO - '_': '/tools/buildbot/bin/python'} 07:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:41:52 INFO - Cleaning up... 07:41:52 INFO - Return code: 0 07:41:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:52 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 0x7fbaae4adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24381c0>, '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 0x24390c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:41:52 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 07:41:52 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 07:41:52 INFO - Using env: {'DISPLAY': ':0', 07:41:52 INFO - 'HOME': '/home/cltbld', 07:41:52 INFO - 'LANG': 'en_US.UTF-8', 07:41:52 INFO - 'LANGUAGE': 'en_US:en', 07:41:52 INFO - 'LOGNAME': 'cltbld', 07:41:52 INFO - 'MAIL': '/var/mail/cltbld', 07:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:52 INFO - 'MOZ_NO_REMOTE': '1', 07:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:52 INFO - 'NO_EM_RESTART': '1', 07:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:52 INFO - 'PWD': '/builds/slave/test', 07:41:52 INFO - 'SHELL': '/bin/bash', 07:41:52 INFO - 'SHLVL': '1', 07:41:52 INFO - 'TERM': 'linux', 07:41:52 INFO - 'TMOUT': '86400', 07:41:52 INFO - 'USER': 'cltbld', 07:41:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 07:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:52 INFO - '_': '/tools/buildbot/bin/python'} 07:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:53 INFO - Downloading/unpacking psutil>=3.1.1 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:55 INFO - Installing collected packages: psutil 07:41:55 INFO - Running setup.py install for psutil 07:41:55 INFO - building 'psutil._psutil_linux' extension 07:41:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:41:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:41:55 INFO - building 'psutil._psutil_posix' extension 07:41:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:41:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:41:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:55 INFO - Successfully installed psutil 07:41:55 INFO - Cleaning up... 07:41:55 INFO - Return code: 0 07:41:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaae4adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24381c0>, '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 0x24390c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:41:55 INFO - Using env: {'DISPLAY': ':0', 07:41:55 INFO - 'HOME': '/home/cltbld', 07:41:55 INFO - 'LANG': 'en_US.UTF-8', 07:41:55 INFO - 'LANGUAGE': 'en_US:en', 07:41:55 INFO - 'LOGNAME': 'cltbld', 07:41:55 INFO - 'MAIL': '/var/mail/cltbld', 07:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:55 INFO - 'MOZ_NO_REMOTE': '1', 07:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:55 INFO - 'NO_EM_RESTART': '1', 07:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:55 INFO - 'PWD': '/builds/slave/test', 07:41:55 INFO - 'SHELL': '/bin/bash', 07:41:55 INFO - 'SHLVL': '1', 07:41:55 INFO - 'TERM': 'linux', 07:41:55 INFO - 'TMOUT': '86400', 07:41:55 INFO - 'USER': 'cltbld', 07:41:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 07:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:55 INFO - '_': '/tools/buildbot/bin/python'} 07:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:41:57 INFO - Installing collected packages: mozsystemmonitor 07:41:57 INFO - Running setup.py install for mozsystemmonitor 07:41:57 INFO - Successfully installed mozsystemmonitor 07:41:57 INFO - Cleaning up... 07:41:57 INFO - Return code: 0 07:41:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbaae4adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24381c0>, '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 0x24390c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:41:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:41:57 INFO - Using env: {'DISPLAY': ':0', 07:41:57 INFO - 'HOME': '/home/cltbld', 07:41:57 INFO - 'LANG': 'en_US.UTF-8', 07:41:57 INFO - 'LANGUAGE': 'en_US:en', 07:41:57 INFO - 'LOGNAME': 'cltbld', 07:41:57 INFO - 'MAIL': '/var/mail/cltbld', 07:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:57 INFO - 'MOZ_NO_REMOTE': '1', 07:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:57 INFO - 'NO_EM_RESTART': '1', 07:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:57 INFO - 'PWD': '/builds/slave/test', 07:41:57 INFO - 'SHELL': '/bin/bash', 07:41:57 INFO - 'SHLVL': '1', 07:41:57 INFO - 'TERM': 'linux', 07:41:57 INFO - 'TMOUT': '86400', 07:41:57 INFO - 'USER': 'cltbld', 07:41:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 07:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:57 INFO - '_': '/tools/buildbot/bin/python'} 07:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:58 INFO - Downloading/unpacking jsonschema==2.5.1 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:42:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:42:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:00 INFO - Downloading functools32-3.2.3-2.tar.gz 07:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:42:00 INFO - warning: no files found matching '*.txt' 07:42:00 INFO - no previously-included directories found matching 'build' 07:42:00 INFO - no previously-included directories found matching 'dist' 07:42:00 INFO - no previously-included directories found matching '.git*' 07:42:00 INFO - Installing collected packages: jsonschema, functools32 07:42:00 INFO - Running setup.py install for functools32 07:42:00 INFO - warning: no files found matching '*.txt' 07:42:00 INFO - no previously-included directories found matching 'build' 07:42:00 INFO - no previously-included directories found matching 'dist' 07:42:00 INFO - no previously-included directories found matching '.git*' 07:42:00 INFO - Successfully installed jsonschema functools32 07:42:00 INFO - Cleaning up... 07:42:00 INFO - Return code: 0 07:42:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:00 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 0x7fbaae4adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24381c0>, '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 0x24390c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:42:00 INFO - Using env: {'DISPLAY': ':0', 07:42:00 INFO - 'HOME': '/home/cltbld', 07:42:00 INFO - 'LANG': 'en_US.UTF-8', 07:42:00 INFO - 'LANGUAGE': 'en_US:en', 07:42:00 INFO - 'LOGNAME': 'cltbld', 07:42:00 INFO - 'MAIL': '/var/mail/cltbld', 07:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:00 INFO - 'MOZ_NO_REMOTE': '1', 07:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:00 INFO - 'NO_EM_RESTART': '1', 07:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:00 INFO - 'PWD': '/builds/slave/test', 07:42:00 INFO - 'SHELL': '/bin/bash', 07:42:00 INFO - 'SHLVL': '1', 07:42:00 INFO - 'TERM': 'linux', 07:42:00 INFO - 'TMOUT': '86400', 07:42:00 INFO - 'USER': 'cltbld', 07:42:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 07:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:00 INFO - '_': '/tools/buildbot/bin/python'} 07:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:42:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:42:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:03 INFO - Downloading docopt-0.6.1.tar.gz 07:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:42:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:42:03 INFO - Running setup.py install for blobuploader 07:42:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:42:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:42:03 INFO - Running setup.py install for requests 07:42:03 INFO - Running setup.py install for docopt 07:42:04 INFO - Successfully installed blobuploader requests docopt 07:42:04 INFO - Cleaning up... 07:42:04 INFO - Return code: 0 07:42:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:04 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 0x7fbaae4adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24381c0>, '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 0x24390c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:42:04 INFO - Using env: {'DISPLAY': ':0', 07:42:04 INFO - 'HOME': '/home/cltbld', 07:42:04 INFO - 'LANG': 'en_US.UTF-8', 07:42:04 INFO - 'LANGUAGE': 'en_US:en', 07:42:04 INFO - 'LOGNAME': 'cltbld', 07:42:04 INFO - 'MAIL': '/var/mail/cltbld', 07:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:04 INFO - 'MOZ_NO_REMOTE': '1', 07:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:04 INFO - 'NO_EM_RESTART': '1', 07:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:04 INFO - 'PWD': '/builds/slave/test', 07:42:04 INFO - 'SHELL': '/bin/bash', 07:42:04 INFO - 'SHLVL': '1', 07:42:04 INFO - 'TERM': 'linux', 07:42:04 INFO - 'TMOUT': '86400', 07:42:04 INFO - 'USER': 'cltbld', 07:42:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 07:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:04 INFO - '_': '/tools/buildbot/bin/python'} 07:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:04 INFO - Running setup.py (path:/tmp/pip-BfZ8_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:04 INFO - Running setup.py (path:/tmp/pip-y0hS7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:04 INFO - Running setup.py (path:/tmp/pip-6nkQKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:04 INFO - Running setup.py (path:/tmp/pip-UDH2ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:04 INFO - Running setup.py (path:/tmp/pip-KHcFlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:04 INFO - Running setup.py (path:/tmp/pip-73Gqv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:04 INFO - Running setup.py (path:/tmp/pip-xM34k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:04 INFO - Running setup.py (path:/tmp/pip-jVwCVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:05 INFO - Running setup.py (path:/tmp/pip-dYJt3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:05 INFO - Running setup.py (path:/tmp/pip-VN1i7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:05 INFO - Running setup.py (path:/tmp/pip-y1pkDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:05 INFO - Running setup.py (path:/tmp/pip-DnfG2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:05 INFO - Running setup.py (path:/tmp/pip-4kR1pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:05 INFO - Running setup.py (path:/tmp/pip-labNgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:05 INFO - Running setup.py (path:/tmp/pip-LZZtTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:05 INFO - Running setup.py (path:/tmp/pip-0BHIFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:05 INFO - Running setup.py (path:/tmp/pip-x5osEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:42:05 INFO - Running setup.py install for manifestparser 07:42:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:42:05 INFO - Running setup.py install for mozcrash 07:42:05 INFO - Running setup.py install for mozdebug 07:42:05 INFO - Running setup.py install for mozdevice 07:42:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Running setup.py install for mozfile 07:42:06 INFO - Running setup.py install for mozhttpd 07:42:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Running setup.py install for mozinfo 07:42:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Running setup.py install for mozInstall 07:42:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Running setup.py install for mozleak 07:42:06 INFO - Running setup.py install for mozlog 07:42:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Running setup.py install for moznetwork 07:42:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Running setup.py install for mozprocess 07:42:06 INFO - Running setup.py install for mozprofile 07:42:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Running setup.py install for mozrunner 07:42:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:42:07 INFO - Running setup.py install for mozscreenshot 07:42:07 INFO - Running setup.py install for moztest 07:42:07 INFO - Running setup.py install for mozversion 07:42:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:42:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:42:07 INFO - Cleaning up... 07:42:07 INFO - Return code: 0 07:42:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:07 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 0x7fbaae4adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24381c0>, '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 0x24390c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:42:07 INFO - Using env: {'DISPLAY': ':0', 07:42:07 INFO - 'HOME': '/home/cltbld', 07:42:07 INFO - 'LANG': 'en_US.UTF-8', 07:42:07 INFO - 'LANGUAGE': 'en_US:en', 07:42:07 INFO - 'LOGNAME': 'cltbld', 07:42:07 INFO - 'MAIL': '/var/mail/cltbld', 07:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:07 INFO - 'MOZ_NO_REMOTE': '1', 07:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:07 INFO - 'NO_EM_RESTART': '1', 07:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:07 INFO - 'PWD': '/builds/slave/test', 07:42:07 INFO - 'SHELL': '/bin/bash', 07:42:07 INFO - 'SHLVL': '1', 07:42:07 INFO - 'TERM': 'linux', 07:42:07 INFO - 'TMOUT': '86400', 07:42:07 INFO - 'USER': 'cltbld', 07:42:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 07:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:07 INFO - '_': '/tools/buildbot/bin/python'} 07:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:07 INFO - Running setup.py (path:/tmp/pip-dFIZ0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:07 INFO - Running setup.py (path:/tmp/pip-2jf02A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:07 INFO - Running setup.py (path:/tmp/pip-xpyDxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:07 INFO - Running setup.py (path:/tmp/pip-9ZXWyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:07 INFO - Running setup.py (path:/tmp/pip-TXYwwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:08 INFO - Running setup.py (path:/tmp/pip-cqvcyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:08 INFO - Running setup.py (path:/tmp/pip-vc1erg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:08 INFO - Running setup.py (path:/tmp/pip-LdBkyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:08 INFO - Running setup.py (path:/tmp/pip-JYybsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:08 INFO - Running setup.py (path:/tmp/pip-uNJCip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:08 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)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:08 INFO - Running setup.py (path:/tmp/pip-qWou22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:08 INFO - Running setup.py (path:/tmp/pip-Bd0t6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:08 INFO - Running setup.py (path:/tmp/pip-tT6Bgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:08 INFO - Running setup.py (path:/tmp/pip-nRzzbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:08 INFO - Running setup.py (path:/tmp/pip-vCrCaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:08 INFO - Running setup.py (path:/tmp/pip-ahROLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:08 INFO - Running setup.py (path:/tmp/pip-9HmxK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:42:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:42:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:10 INFO - Downloading blessings-1.6.tar.gz 07:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:42:10 INFO - Installing collected packages: blessings 07:42:10 INFO - Running setup.py install for blessings 07:42:11 INFO - Successfully installed blessings 07:42:11 INFO - Cleaning up... 07:42:11 INFO - Return code: 0 07:42:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:42:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:11 INFO - Reading from file tmpfile_stdout 07:42:11 INFO - Current package versions: 07:42:11 INFO - argparse == 1.2.1 07:42:11 INFO - blessings == 1.6 07:42:11 INFO - blobuploader == 1.2.4 07:42:11 INFO - docopt == 0.6.1 07:42:11 INFO - functools32 == 3.2.3-2 07:42:11 INFO - jsonschema == 2.5.1 07:42:11 INFO - manifestparser == 1.1 07:42:11 INFO - mozInstall == 1.12 07:42:11 INFO - mozcrash == 0.17 07:42:11 INFO - mozdebug == 0.1 07:42:11 INFO - mozdevice == 0.48 07:42:11 INFO - mozfile == 1.2 07:42:11 INFO - mozhttpd == 0.7 07:42:11 INFO - mozinfo == 0.9 07:42:11 INFO - mozleak == 0.1 07:42:11 INFO - mozlog == 3.2 07:42:11 INFO - moznetwork == 0.27 07:42:11 INFO - mozprocess == 0.22 07:42:11 INFO - mozprofile == 0.28 07:42:11 INFO - mozrunner == 6.11 07:42:11 INFO - mozscreenshot == 0.1 07:42:11 INFO - mozsystemmonitor == 0.3 07:42:11 INFO - moztest == 0.7 07:42:11 INFO - mozversion == 1.4 07:42:11 INFO - psutil == 3.1.1 07:42:11 INFO - requests == 1.2.3 07:42:11 INFO - wsgiref == 0.1.2 07:42:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:11 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 0x7fbaae4adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24381c0>, '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 0x24390c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:42:11 INFO - Using env: {'DISPLAY': ':0', 07:42:11 INFO - 'HOME': '/home/cltbld', 07:42:11 INFO - 'LANG': 'en_US.UTF-8', 07:42:11 INFO - 'LANGUAGE': 'en_US:en', 07:42:11 INFO - 'LOGNAME': 'cltbld', 07:42:11 INFO - 'MAIL': '/var/mail/cltbld', 07:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:11 INFO - 'MOZ_NO_REMOTE': '1', 07:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:11 INFO - 'NO_EM_RESTART': '1', 07:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:11 INFO - 'PWD': '/builds/slave/test', 07:42:11 INFO - 'SHELL': '/bin/bash', 07:42:11 INFO - 'SHLVL': '1', 07:42:11 INFO - 'TERM': 'linux', 07:42:11 INFO - 'TMOUT': '86400', 07:42:11 INFO - 'USER': 'cltbld', 07:42:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 07:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:11 INFO - '_': '/tools/buildbot/bin/python'} 07:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:42:11 INFO - Cleaning up... 07:42:11 INFO - Return code: 0 07:42:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaae4adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24381c0>, '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 0x24390c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:42:11 INFO - Using env: {'DISPLAY': ':0', 07:42:11 INFO - 'HOME': '/home/cltbld', 07:42:11 INFO - 'LANG': 'en_US.UTF-8', 07:42:11 INFO - 'LANGUAGE': 'en_US:en', 07:42:11 INFO - 'LOGNAME': 'cltbld', 07:42:11 INFO - 'MAIL': '/var/mail/cltbld', 07:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:11 INFO - 'MOZ_NO_REMOTE': '1', 07:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:11 INFO - 'NO_EM_RESTART': '1', 07:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:11 INFO - 'PWD': '/builds/slave/test', 07:42:11 INFO - 'SHELL': '/bin/bash', 07:42:11 INFO - 'SHLVL': '1', 07:42:11 INFO - 'TERM': 'linux', 07:42:11 INFO - 'TMOUT': '86400', 07:42:11 INFO - 'USER': 'cltbld', 07:42:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 07:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:11 INFO - '_': '/tools/buildbot/bin/python'} 07:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:42:11 INFO - Cleaning up... 07:42:11 INFO - Return code: 0 07:42:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaae4adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24381c0>, '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 0x24390c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:42:11 INFO - Using env: {'DISPLAY': ':0', 07:42:11 INFO - 'HOME': '/home/cltbld', 07:42:11 INFO - 'LANG': 'en_US.UTF-8', 07:42:11 INFO - 'LANGUAGE': 'en_US:en', 07:42:11 INFO - 'LOGNAME': 'cltbld', 07:42:11 INFO - 'MAIL': '/var/mail/cltbld', 07:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:11 INFO - 'MOZ_NO_REMOTE': '1', 07:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:11 INFO - 'NO_EM_RESTART': '1', 07:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:11 INFO - 'PWD': '/builds/slave/test', 07:42:11 INFO - 'SHELL': '/bin/bash', 07:42:11 INFO - 'SHLVL': '1', 07:42:11 INFO - 'TERM': 'linux', 07:42:11 INFO - 'TMOUT': '86400', 07:42:11 INFO - 'USER': 'cltbld', 07:42:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 07:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:11 INFO - '_': '/tools/buildbot/bin/python'} 07:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:11 INFO - Downloading/unpacking flake8 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:42:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:42:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:42:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:42:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:42:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:42:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:42:14 INFO - no previously-included directories found matching 'docs/_build' 07:42:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:42:14 INFO - Running setup.py install for pep8 07:42:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:42:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:42:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:42:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:42:14 INFO - no previously-included directories found matching 'docs/_build' 07:42:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:42:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:42:14 INFO - Cleaning up... 07:42:14 INFO - Return code: 0 07:42:14 INFO - Running post-action listener: _resource_record_post_action 07:42:14 INFO - Running post-action listener: _start_resource_monitoring 07:42:14 INFO - Starting resource monitoring. 07:42:14 INFO - ##### 07:42:14 INFO - ##### Finished create-virtualenv step (success) 07:42:14 INFO - ##### 07:42:14 INFO - ##### 07:42:14 INFO - ##### Running install step. 07:42:14 INFO - ##### 07:42:14 INFO - Running pre-action listener: _resource_record_pre_action 07:42:14 INFO - Running main action method: install 07:42:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:15 INFO - Reading from file tmpfile_stdout 07:42:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:42:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:42:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:42:15 INFO - Reading from file tmpfile_stdout 07:42:15 INFO - Output received: 07:42:15 INFO - Usage: mozinstall [options] installer 07:42:15 INFO - Options: 07:42:15 INFO - -h, --help show this help message and exit 07:42:15 INFO - -d DEST, --destination=DEST 07:42:15 INFO - Directory to install application into. [default: 07:42:15 INFO - "/builds/slave/test"] 07:42:15 INFO - --app=APP Application being installed. [default: firefox] 07:42:15 INFO - mkdir: /builds/slave/test/build/application 07:42:15 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'] 07:42:15 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 07:42:31 INFO - Reading from file tmpfile_stdout 07:42:31 INFO - Output received: 07:42:31 INFO - /builds/slave/test/build/application/firefox/firefox 07:42:31 INFO - Running post-action listener: _resource_record_post_action 07:42:31 INFO - ##### 07:42:31 INFO - ##### Finished install step (success) 07:42:31 INFO - ##### 07:42:31 INFO - ##### 07:42:31 INFO - ##### Running run-tests step. 07:42:31 INFO - ##### 07:42:31 INFO - Running pre-action listener: _resource_record_pre_action 07:42:31 INFO - Running main action method: run_tests 07:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:42:31 INFO - Python 2.7.3 07:42:31 INFO - Return code: 0 07:42:31 INFO - grabbing minidump binary from tooltool 07:42: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')]} 07:42:31 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 0x24381c0>, '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 0x24390c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2439550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:42:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:42:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:42:31 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 07:42:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:42:31 INFO - Return code: 0 07:42:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:42:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:42:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:42:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:42:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:42:32 INFO - Return code: 0 07:42:32 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/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 07:42:32 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/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 07:42:32 INFO - Using env: {'DISPLAY': ':0', 07:42:32 INFO - 'HOME': '/home/cltbld', 07:42:32 INFO - 'LANG': 'en_US.UTF-8', 07:42:32 INFO - 'LANGUAGE': 'en_US:en', 07:42:32 INFO - 'LOGNAME': 'cltbld', 07:42:32 INFO - 'MAIL': '/var/mail/cltbld', 07:42:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:42:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:32 INFO - 'MOZ_NO_REMOTE': '1', 07:42:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:32 INFO - 'NO_EM_RESTART': '1', 07:42:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:32 INFO - 'PWD': '/builds/slave/test', 07:42:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:42:32 INFO - 'SHELL': '/bin/bash', 07:42:32 INFO - 'SHLVL': '1', 07:42:32 INFO - 'TERM': 'linux', 07:42:32 INFO - 'TMOUT': '86400', 07:42:32 INFO - 'USER': 'cltbld', 07:42:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007', 07:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:32 INFO - '_': '/tools/buildbot/bin/python'} 07:42:32 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/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 07:42:32 INFO - mozversion application_buildid: 20160627050926 07:42:32 INFO - mozversion application_changeset: fd8d4ad885aa3adcc5d620d2a03aab15577664fc 07:42:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:42:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:42:32 INFO - mozversion application_name: Firefox 07:42:32 INFO - mozversion application_remotingname: firefox-dev 07:42:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:42:32 INFO - mozversion application_vendor: Mozilla 07:42:32 INFO - mozversion application_version: 49.0a2 07:42:32 INFO - mozversion platform_buildid: 20160627050926 07:42:32 INFO - mozversion platform_changeset: fd8d4ad885aa3adcc5d620d2a03aab15577664fc 07:42:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:42:32 INFO - mozversion platform_version: 49.0a2 07:42:32 INFO - using testdate: 1467038552 07:42:32 INFO - actual date: 1467038552 07:42:32 INFO - starting webserver on 'localhost:53518' 07:42:32 INFO - SUITE-START | Running 2 tests 07:42:32 INFO - TEST-START | dromaeo_css 07:42:32 INFO - operating with platform_type : linux_ 07:42:32 INFO - Initialising browser for dromaeo_css test... 07:42:32 INFO - TEST-INFO | started process 10373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTFJixd/profile http://localhost:53518/getInfo.html) 07:42:37 INFO - PROCESS | 10373 | __metrics Screen width/height:1600/1200 07:42:37 INFO - PROCESS | 10373 | colorDepth:24 07:42:37 INFO - PROCESS | 10373 | Browser inner width/height: 1024/697 07:42:37 INFO - PROCESS | 10373 | __metrics 07:42:37 ERROR - PROCESS | 10373 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 07:42:38 INFO - TEST-INFO | 10373: exit 0 07:42:38 INFO - Browser initialized. 07:42:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:42:38 INFO - TEST-INFO | started process 10502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTFJixd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:50 INFO - PROCESS | 10502 | RSS: Main: 156028928 07:42:50 INFO - PROCESS | 10502 | 07:43:40 INFO - PROCESS | 10502 | 1467038620145 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:45:48 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53518/tests/dromaeo/cssquery-ext.html) 07:45:49 INFO - PROCESS | 10502 | RSS: Main: 159211520 07:45:49 INFO - PROCESS | 10502 | 07:48:51 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-ext.html (next: http://localhost:53518/tests/dromaeo/cssquery-jquery.html) 07:48:52 INFO - PROCESS | 10502 | RSS: Main: 157736960 07:48:52 INFO - PROCESS | 10502 | 07:51:54 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53518/tests/dromaeo/cssquery-mootools.html) 07:51:54 INFO - PROCESS | 10502 | RSS: Main: 157470720 07:51:54 INFO - PROCESS | 10502 | 07:54:56 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53518/tests/dromaeo/cssquery-prototype.html) 07:54:56 INFO - PROCESS | 10502 | RSS: Main: 157306880 07:54:56 INFO - PROCESS | 10502 | 07:57:59 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53518/tests/dromaeo/cssquery-yui.html) 07:58:00 INFO - PROCESS | 10502 | RSS: Main: 158834688 07:58:00 INFO - PROCESS | 10502 | 08:01:02 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-yui.html (next: http://localhost:53518/tests/dromaeo/cssquery-dojo.html) 08:01:02 INFO - PROCESS | 10502 | RSS: Main: 159342592 08:01:02 INFO - PROCESS | 10502 | 08:01:02 INFO - PROCESS | 10502 | __start_tp_report 08:01:02 INFO - PROCESS | 10502 | _x_x_mozilla_page_load 08:01:02 INFO - PROCESS | 10502 | _x_x_mozilla_page_load_details 08:01:02 INFO - PROCESS | 10502 | |i|pagename|runs| 08:01:02 INFO - PROCESS | 10502 | |0;dojo.html;3443.5523381960343;3493.47597860321;3511.28018756155;3526.365254254233;3547.627499112593;5870.530357571395;5883.88232235355;5901.675407852572;5964.194833697449;5994.190784244126;5972.462478376945;6010.939890601093;6012.038073908176;6016.7593296268205;6029.819105426834;5246.370435547739;5294.444083371249;5377.3009508764;5399.919001214985;5422.15956526739;5254.080535906221;5300.09898317285;5323.494268044549;5383.246345511631;5392.595555333346;5369.62412631116;5384.461553844623;5401.972990135044;5410.134378499441;5413.079776437995;5356.54469370104;5369.999999999981;5465.480779325958;5465.961467321196;5467.0705979983495;5348.064088784486;5351.090314646481;5352.197170424429;5382.515573598355;5434.565234781247;5547.44525547446;5674.716264186815;5699.373068962411;5739.053056245714;5802.12968054791;6329.8417539561415;6332.905006424908;6341.080543321239;6346.238451385863;6369.8407539811415;6153.261608606951;6378.298387177407;6401.423871851509;6413.1662883825275;6414.903776443311;5794.62334948227;5831.387704291031;5892.764289428461;5931.525477961753;5947.6431414115295;6477.805665829938;6523.151990241333;6550.541462097607;6601.801945941629;6608.306127856602;6127.448529632355;6132.908006379907;6251.187345645037;6308.905366419507;6316.9368306317265;6333.2400111985935;6338.58799178052;6355.5551111421755;6371.076193951851;6395.232572091379;6310.5267104967315;6337.619742815354;6353.491720662429;6361.045843123568;6363.33185015576;6132.478739307119;6172.722227499773;6172.814815555541;6239.06414037898;6350.8412289692205;4759.119562880878;4771.618270538349;4772.689775164673;4792.904141917142;4793.688410253322;4242.215190189763;4262.42457268271;4282.272013757669;4293;4306;5977.432143946318;6006.849828754316;6010.639361638316;6037.607555508878;6093.390660933871;6143.235544005215;6238.438540531374;6280.466160376419;6294.65379404128;6394.712237949303;5890.941090589039;6073.787417440369;6077.209962704908;6085.847853803691;6090.177825993434;5241.397239317527;5266.947330526646;5313.362396512366;5345.893082138336;5350.063738845764;6537.836554086186;6540.149780528596;6573.605583664996;6574.145361103026;6602.60384376939;6060.363661815622;6262.655553944577;6311.936880631319;6325.96837015812;6353.618782873043;6474.482041436768;6555.770548030796;6570.441512471493;6680.933190668031;6686.665666716547;6282.371762823681;6345.333739957423;6347.619142851444;6358.650274234961;6358.713857876314;6176.042713379434;6260.843478913063;6425.967870160619;6433.935660643334;6436.613803171825;6124.960759790135;6204.441600255998;6217.222847144107;6230.626162430269;6235.875282494234;6147.139400484025;6210.037444196157;6215.12988181664;6222.782202622887;6233.158523599437;5918.852028699144;6052.909206361996;6062.393760623902;6099.542534309856;6134.754609815557;6258.092576576462;6269.905951410641;6274.309825919237;6296.5592408530965;6296.716647750771;6185.969070154621;6200.3799620037635;6207.255129384503;6210.72051757681;6212.06818977157 08:01:02 INFO - PROCESS | 10502 | |1;ext.html;608.9725962331695;663.4592806862407;672.3612568060344;680.4318394140892;683.627423054435;45828;46707.76646116769;47150.76424617876;47200.58398248049;50483.24275135876;47664.52335476644;48021.279680804815;48238.75880620601;48328;48386.75806620962;9084.909150908488;9196.03441638625;9218.907810921872;9224.169824715775;9256.398334108295;9045;9165;9180.44917304964;9181.632734690604;9193.586288616994;9158.404703694272;9190.35667503275;9216.400933939307;9239.399439036475;9242.86135707965;9068.138526839972;9095.363324567283;9141.908580914205;9154.130357616015;9172.770680732969;9098.499582522958;9111.772205694844;9122.22461090808;9160.450372977642;9185.17333439987;44109.77945110286;44399.778001109786;44425.33361999573;44446.11107777859;44505;4010.6791456683395;4103.958960410388;4514.142312960527;4579.656525760582;4617.792199351004;33526;34006.31987360239;34057.31885362304;34131.82934085339;35312.64687353145;4324.200022995725;4369.650427965755;4407.118576284756;4408.58118478744;4420.762186587728;383529;384544;385081;385366;386909.0654546737;62607.37392626015;62927.37072629307;62943;62958.685206573675;63061.36938630647;38699.2260154801;39519;39552.60447395547;41339.37990930139;41442.792786035876;19461.805381946284;19560.315388961317;19573.902130489256;19616;19634.21463141487;15005.474808381872;15141.848581514265;15184.316705748268;15205.163715995726;15213.391464341303;21278.78721212799;21339.14643414277;21484.248051318442;21516.569668606855;21604;7571.46999710026;7659.808504787314;7761;7824.37405007598;7963.496061732819;1079.5681727309138;1088.7985722641338;1095.7921581128346;1114.9554017839357;1228.0789407944042;33151.502727459105;33179.83410082934;33346.3330733384;33653;34145.31709365849;1119.4626579241847;1177.9941100294616;1211.6910187902029;1231.4027696567157;1277.9680507987375;17211.139443027798;17362.21870015827;17673.558161046076;17796.199171037075;18052.368167114088;586640;588135;588326;591491;596557;64053.35946640567;64711;64920.35079649238;65069.349306507276;65225.34774652288;1472.0632338484577;1487.7247709173837;1493.611660968156;1503.796987406708;1516.696660667871;31943.520847187774;32272.193195170308;32380.514292285163;33075.50386744153;33391.165220869676;54320.45679543312;54543;54680.45319546913;54701.72649136729;54991.725041374535;459278;463201;464517;464585;464687;30130.397392052473;30598.388032239676;30997.845010774803;31390;31580.368392632477;52412.7379363116;52593.7370313146;53092.73453632707;53281;53937;44735.55264447444;45404.54595454003;45598.54401456076;45714;46657.30014049724;43868.122637547705;44720;44927;45808;45821.31268030916;43685;43913.78043109764;44318.556814431446;44577;44698;38887.22225555417;39176.80411597924;39393.2121357577;39418;39534;29657.85171074131;29913.85043074771;30137.849310753307;30233.244168895955;30529.542056868722 08:01:02 INFO - PROCESS | 10502 | |2;jquery.html;426.7284482331857;434.819549886797;438.79595987865633;439.7449479302005;440.1263491968443;18635.62728745424;19312.613747725056;20284.087216075313;20334.491637709045;20409.48976275594;16564.585885352873;18720.906395468002;19431.805681943177;20177.78933264005;20265.39203823884;5881.558883083764;6016.8495787605225;6050.42520960508;6053.303870054956;6062.514998800108;5815.156802263669;5893.673923367251;5925.822225333247;5978.40215978403;5993.970030149843;5874.9412505874825;5901.05583106703;5909.290885093795;5913.497352725002;5918.674472903988;5707.686077265748;5810.389909059572;5824.912626310566;5870.354261031283;5918.615290006136;5131.204663277198;5155.484451554815;5166.974165129188;5199.324087868553;5199.974000129975;22796.316110516713;23502.529949401087;23785.286441406784;24134.275971720876;24306.392340191636;2145;2406.6991626046743;2485.8632775197357;2545.4145546524405;2680.597910313449;10655.413952232624;12264.693382665415;15005.24973751308;15480;15524.379024838992;2093.16273490605;2121.2151503943487;2234.2961966980347;2340.578695834749;2382.749811269809;83548;96576.03423965741;97952;99292;103063.48468257686;17362.746127198665;18291.908540457214;18441.1701473434;18520.444386668423;19121.330753423565;35166.648333516336;35236.82381588076;35395.64604353975;35433.64566354355;35710.28579428397;10669.733256668645;11361.829572556418;11432.199746017699;11434.656960291204;11458.77082458363;9531.475768832643;9588.37675551087;9671.564779584936;9681.51592420376;9824.803503930025;9269.655899894478;9511.90488095124;9589.520523973773;9616.95191524038;9664.855027174597;3362;3605.441156620728;3721.348763966295;3750.212455384345;3768.4347347897487;978.7259567321162;1005.1657124586576;1021.6475316015963;1060.984085238722;1103.5089385223498;19461;19917.701234481494;19960.500987475138;20021.899890500456;20116.89941550312;1037.6886933919793;1058.25921854702;1064.1752641702742;1099;1152.8847115288572;10834.566617335377;11011.559537618567;11114.944425277983;11129.833052504218;11242.718932026764;552013;557944;564377;566657;567123;67620;83344;87266;98039;101324.49337753412;962.9037096290455;992.2310209587628;992.9354591951644;995.348047029197;1059.078601616583;18048.729269061238;18058.645601580196;18105.547361316072;18211.635767284315;18470.353537626117;41536;41771.582284176766;41961.64602476979;42942.35586466268;44474.332885007396;58698.70650646719;60471.69764151151;60740;61334.69332653308;62032;7873;8228.958855205685;8420.5789710513;8503.872441913252;9083.863742043743;9784.02159784016;13786.724265514433;13883.39305381816;13966;14217.928910355797;6013.067974463965;9600.519974001132;11871.397361356107;11987.520499179935;12210.633680989584;11978.401079946143;12004.339761313211;12083.335416552174;12136.211146275464;12666.556670516487;12238.75522489563;12358.320292384005;12515.4368053436;12692.619221423372;12823;7877.7636670899965;8253.79365515867;8464.407491475784;8530.74407767768;8753.91246087531;12276.570320038756;12373.505059797508;12420.689482763004;12421.130520863453;12494.37528123572 08:01:02 INFO - PROCESS | 10502 | |3;mootools.html;1554.3860175230789;1600.735878580034;1753.4564285071629;1868.729034290028;1873.5597134673358;7843.411744119186;9046.638134474613;9267.119623635752;9733.464659443736;9852.458114803683;9063.773405664862;9314.208292295147;9364.578593963271;9381.81236375272;9387.530623468834;2489.1785710715512;2513.183215454975;2529.810264230181;2530.5571524983147;2533.0121252711456;2406.338256979327;2453.472503411766;2460.151247819508;2461.59383701689;2461.716902556202;2417.9153729619466;2449.0448724997264;2456.7666071723156;2461.9876900615473;2463.950720985579;2452.852828830258;2464.125235541375;2478.033566908916;2502.3744063984004;2516.081630204971;2393.772591603795;2396.113438027941;2398.5442765874427;2408.9879550602136;2470.049031123013;9349.813003739888;9355.625774968994;9423.34036617437;9431.952840235756;9468.763280917963;5415.675059496442;5522.641028333145;5523.6685798852195;5527.695976721278;5533.031719449121;3405.6594340565744;3472.7742696724886;3546.060294022086;3562.305350456662;3568.6431356864364;1063.3885515828429;1131.7736452709491;1132.7847708935276;1133.2010932292796;1137.6075254037344;12769.361531923367;12833.294168820712;12842.9357853212;12843.165194262436;12879.356032198446;4846.151923413388;4905.288733133676;4958.42978057528;5000.74996250186;5035.16919708244;10921.672349829518;10970.780584388267;11035.8964103589;11072.612458563912;11090.001899829054;5417.864553386197;5481.588880833953;5505.697186654692;5552.5280351169795;5568.52667523257;4474.530174331649;4967.254911763264;5060.7216603086445;5220.817271395483;5231;4291.206126866539;4376.671749618791;4412.0955204183065;4425.491068527161;4533.77331133442;1337.3046016071783;1398.5175114585452;1417.6030711400824;1422.1253928833694;1422.7581311177125;1002.644061358222;1029.1509504658536;1039.095986491757;1040.765827688764;1043.4678314059884;6475.222973243241;6573.57271777333;6658.167729033871;6664.067030615718;6671.299513551105;490.40415894688124;496.0599663637387;496.92794544791525;508.461031306816;509.72220140023774;4420.171090502081;4574.176648203355;4600.056988317387;4634.304854271886;4668.229742092517;10852.620158294421;11027.889721102687;11072.833907491395;11113.83329250062;11189.160812939062;10904.672859814218;11068.944655276833;11122.44387780624;11152.553897843994;11164.385958772345;8493.957530212432;8501.234888860032;8528.40301178924;8660.610272537751;8664.220220180214;6249.875002500015;6275.811725648238;6380.968095159495;6386.297507274289;6396.552241343062;10182.592696292066;10217.642382516577;10261.17910567138;10274.897251027693;10387.844182337421;10394.58421663125;10396.428196449267;10414.166866650801;10496.160307175254;10556.261061725605;8012.559309238048;8054.436189466681;8370.958145209235;8378.916210838057;8609.612567434606;9259.212966897889;9319.30105242096;9441.622335106793;9467.526623668651;9468.384555003902;8125.837483250184;8132.552709600792;8431.620577073923;8443.66225350979;8564.914350856412;8309.626066827128;8332.291755200877;8374.916250837414;8395.496270223806;8397.412181147261;7524.473286869867;7573;7623.047119110111;7637.198094200251;7643.235676432535;5695;5777.826665200051;5842.152887831326;5882.117682347511;5894.705264736832;5554.805581804618;5685.971570142123;5750.079987202028;5861.1794348792055;5945.256842894638 08:01:02 INFO - PROCESS | 10502 | |4;prototype.html;345.6871531264205;348.4738045551218;349.91252186953255;357.30682475996565;358.2315932325161;5653.4911857932775;5797.594168408213;5820.417958204177;5899.823005309837;5959.6424214547105;5719.742611582478;5753.65478071316;5775.67898458387;5776.59563830532;5794.565407594426;4455.398521199629;4482.97758511207;4484.708493947883;4495.235809912323;4502.639788816903;4437;4511.4135162429;4519.909601807962;4526.366308716782;4548.226801443746;4420.469543654766;4472;4477.3731677565165;4480.596746292833;4482.148391805563;4471.262241730111;4489.506154323039;4507.408240261862;4518.644406677983;4535.954640453586;3880.8447662093763;3922.882313530599;3933.7639741615594;3976.940345894785;3985;5561.304836895388;5583.944160558423;5593.188987596816;5602.159676048625;5645.294338207724;5125.154349532323;5145.948540514584;5148.04374337753;5189.221616757479;5189.610779191576;5970;6078.209832721762;6107.0228763397645;6126.816195514097;6138.938610613882;4308.633766129883;4329.415528903589;4340.392345071693;4360.716553424018;4362.149380870732;6189.257289125334;6388.520860935402;6418.8716225675225;6451.1936007999;6462.32145624712;4399.428074350378;4399.780010999501;4405.118976204772;4421.248387774086;4424.579664931826;4483.193025255486;4491.887702807456;4509.391232183679;4509.444241736595;4512.548745125461;5069.8479045627955;5126.564242039394;5127.307813445212;5134.204198349262;5152.4847515248175;5903.3801450847905;5950.732217050243;6106.664133472613;6160.199174107427;6168.2242990653485;1527.2745445913324;1553.6193632560096;1555.9066456012677;1558.1741676911256;1558.4000159938505;954.3033585482636;979.7893452907516;979.8138353712772;980.7302991677345;990.64336838738;5289.259503669489;5298.92051619226;5303.681779093266;5309.814156504581;5315.840524784263;5545.724483368767;5588.385277619459;5660.122680984454;5668.26312579362;5671.071835575842;4961.6526843121355;5243.868903277372;5266.894662106736;5380.704061276668;5387.24578559002;3016.441958237689;3038.255627371264;3047.207725991258;3052.206426329126;3078.5228289615147;5522.587253825341;5764.625299355528;5776.277965254343;5813.941860581424;5838.67887266196;5592.3009623797025;5627.606067575231;5696.430356964271;5705.288413475941;5721.284839395075;5708.514776243983;5725.249961275371;5759.395263497357;5789.710514474175;5793.536517078624;5310.362756469249;5545.833624991256;5581.665100094007;5581.711498285684;5594.300712410949;5433.429489903503;5518.344496651069;5541.418151094238;5552.167174923794;5566.415526369673;5721.427857214412;5749.8275051748515;5772.480476757112;5772.585716499484;5795.24661793981;3857.672097871712;4049.4128351388295;4083.8570650027104;4094.1402305514985;4097.467329247179;5589.301337332833;5608.663480191201;5643.209950606836;6161.4146656067605;6425.10048593188;6215;6237.1891654084675;6243.001119820807;6250.9062364065485;6252.280987686474;6044.395560444096;6155.630662160284;6225.626462412089;6230.408111229426;6253;6103.664298463627;6107.84730381744;6114.6636934969;6118.571699980958;6140.556969112345;6144.38556144382;6214.25428948529;6223.688815559294;6238.532110091671;6287.245530536182;5836.649801011953;6069.908951365821;6131.620385413246;6134.846628834315;6135.386461354007 08:01:02 INFO - PROCESS | 10502 | |5;yui.html;796.4663675337526;799.9040115186175;860.832137733142;870.1168314161132;898.4384759525296;15306.540803775877;15325.080495170283;15419.845801541982;15671.84328156718;16392.83607163928;15935.20323983802;16057.759133613004;16147.91926040371;16148.434804781835;16185.514434566981;745.634639026877;850.9106543812873;876.9035406105323;878.5607196401799;879.7844528090627;859;865.126222515261;866.7919699272193;868.3617541107282;868.7176667583029;916.7295647783919;921.5622579274824;922.1009515722184;922.5479515037616;922.9261659067292;910.5993362920294;912.1744820937063;916.4043371808344;917.857732051533;919.6919032124247;672.2806596941275;676.719161547957;677.485111315399;677.861038487109;679.7281087564965;13573;13602.31988400586;13609.251491167981;13679;13712.588622341245;15749.370025198978;16225.59436014109;16373.09947952862;16595.17024148788;16668.33326666932;13281.800772988412;13290;13331.400086996011;13401.932990335083;13753.862461375358;4170.582941705805;4184.407357657276;4234.788260586989;4251.149770046003;4266.765327906964;75446.24553754447;76291.61854190694;76329.23670763276;76428;76553.61723191405;12474.688132796753;12915.806262906064;12962.546310879263;12995.545155919686;13154.21074735519;23894.163704270613;24030.158944436862;24202.515949680906;24219.39451513726;24953.251402457954;9210.81578368429;9223.953880230556;9237.474064587885;9242.07579242084;9388.57751401175;5111.207762796773;5232.686038837682;5236.476352364733;5264.578833693296;5320.201969704575;3634.3821550336506;3734.6638802507905;3748.2128752962185;3756.586775454698;3763.49192858966;543.7960764713232;605.9394060593905;614.671150934248;615.2647586134616;615.5937081526171;665.3346653346654;771.4214339245566;792.6512334572769;827.2802661684373;828.035338830256;11111.55553777856;11233.660333212621;11287.266327688674;11585.768284634429;11753.353565553805;642.6208536963214;667.4760313154151;725.9963700181571;781.878808784628;839.6641343462663;5211.765470553834;5281.663947312293;5326.6005049621435;5340.332458442695;5408.486193811582;72586.27413725795;111412;111899.44050279696;112997;118463.40768296276;94785.52607236919;95297;97666;98005.50997244968;100529.49735251277;88203.55898220467;88354;88549.55725221461;90877.54561227284;92824;9149.63401463934;9518.737868909626;9554.713358599252;9613.182879455046;9854.753631159278;52407;53202;53243;54149.45850541444;54935.45064549303;65776;76358.6182069086;76808.46383072196;79471;79997;12116.575919842764;12547.43536540876;13222.537211197561;13490.392932318266;13536.59390218295;14022.368993395527;14156.575302740934;14229.857701422854;14242.643933901736;14284.642883927569;12397.93801030989;12709.872901270868;12967.286799225756;12988;13194.472221111047;13796.448142074205;13893.513727019506;13919.904719368524;14029.298535073001;14070.296485175904;13398.196108233537;13558.728825423634;13787.655308616964;14004.579862604138;14362.066465679698;11485.770284594095;11673.766524669629;11710.70723231926;11835.349055802013;12000.63998080059;10352.585896564053;10394.272400931863;10467.214958877963;10487.318324308895;11372 08:01:02 INFO - PROCESS | 10502 | __end_tp_report 08:01:02 INFO - PROCESS | 10502 | __start_cc_report 08:01:02 INFO - PROCESS | 10502 | _x_x_mozilla_cycle_collect,339 08:01:02 INFO - PROCESS | 10502 | __end_cc_report 08:01:02 INFO - PROCESS | 10502 | __startTimestamp1467039662436__endTimestamp 08:01:02 INFO - PROCESS | 10502 | 08:01:02 INFO - PROCESS | 10502 | ------- Summary: start ------- 08:01:02 INFO - PROCESS | 10502 | Number of tests: 6 08:01:02 INFO - PROCESS | 10502 | 08:01:02 INFO - PROCESS | 10502 | [#0] dojo.html Cycles:165 Average:5879.52 Median:6132.48 stddev:676.89 (11.0%) stddev-sans-first:651.44 08:01:02 INFO - PROCESS | 10502 | Values: 3443.6 3493.5 3511.3 3526.4 3547.6 5870.5 5883.9 5901.7 5964.2 5994.2 5972.5 6010.9 6012.0 6016.8 6029.8 5246.4 5294.4 5377.3 5399.9 5422.2 5254.1 5300.1 5323.5 5383.2 5392.6 5369.6 5384.5 5402.0 5410.1 5413.1 5356.5 5370.0 5465.5 5466.0 5467.1 5348.1 5351.1 5352.2 5382.5 5434.6 5547.4 5674.7 5699.4 5739.1 5802.1 6329.8 6332.9 6341.1 6346.2 6369.8 6153.3 6378.3 6401.4 6413.2 6414.9 5794.6 5831.4 5892.8 5931.5 5947.6 6477.8 6523.2 6550.5 6601.8 6608.3 6127.4 6132.9 6251.2 6308.9 6316.9 6333.2 6338.6 6355.6 6371.1 6395.2 6310.5 6337.6 6353.5 6361.0 6363.3 6132.5 6172.7 6172.8 6239.1 6350.8 4759.1 4771.6 4772.7 4792.9 4793.7 4242.2 4262.4 4282.3 4293.0 4306.0 5977.4 6006.8 6010.6 6037.6 6093.4 6143.2 6238.4 6280.5 6294.7 6394.7 5890.9 6073.8 6077.2 6085.8 6090.2 5241.4 5266.9 5313.4 5345.9 5350.1 6537.8 6540.1 6573.6 6574.1 6602.6 6060.4 6262.7 6311.9 6326.0 6353.6 6474.5 6555.8 6570.4 6680.9 6686.7 6282.4 6345.3 6347.6 6358.7 6358.7 6176.0 6260.8 6426.0 6433.9 6436.6 6125.0 6204.4 6217.2 6230.6 6235.9 6147.1 6210.0 6215.1 6222.8 6233.2 5918.9 6052.9 6062.4 6099.5 6134.8 6258.1 6269.9 6274.3 6296.6 6296.7 6186.0 6200.4 6207.3 6210.7 6212.1 08:01:02 INFO - PROCESS | 10502 | 08:01:02 INFO - PROCESS | 10502 | [#1] ext.html Cycles:180 Average:64727.16 Median:44541.00 stddev:129168.43 (290.0%) stddev-sans-first:129441.07 08:01:02 INFO - PROCESS | 10502 | Values: 609.0 663.5 672.4 680.4 683.6 45828.0 46707.8 47150.8 47200.6 50483.2 47664.5 48021.3 48238.8 48328.0 48386.8 9084.9 9196.0 9218.9 9224.2 9256.4 9045.0 9165.0 9180.4 9181.6 9193.6 9158.4 9190.4 9216.4 9239.4 9242.9 9068.1 9095.4 9141.9 9154.1 9172.8 9098.5 9111.8 9122.2 9160.5 9185.2 44109.8 44399.8 44425.3 44446.1 44505.0 4010.7 4104.0 4514.1 4579.7 4617.8 33526.0 34006.3 34057.3 34131.8 35312.6 4324.2 4369.7 4407.1 4408.6 4420.8 383529.0 384544.0 385081.0 385366.0 386909.1 62607.4 62927.4 62943.0 62958.7 63061.4 38699.2 39519.0 39552.6 41339.4 41442.8 19461.8 19560.3 19573.9 19616.0 19634.2 15005.5 15141.8 15184.3 15205.2 15213.4 21278.8 21339.1 21484.2 21516.6 21604.0 7571.5 7659.8 7761.0 7824.4 7963.5 1079.6 1088.8 1095.8 1115.0 1228.1 33151.5 33179.8 33346.3 33653.0 34145.3 1119.5 1178.0 1211.7 1231.4 1278.0 17211.1 17362.2 17673.6 17796.2 18052.4 586640.0 588135.0 588326.0 591491.0 596557.0 64053.4 64711.0 64920.4 65069.3 65225.3 1472.1 1487.7 1493.6 1503.8 1516.7 31943.5 32272.2 32380.5 33075.5 33391.2 54320.5 54543.0 54680.5 54701.7 54991.7 459278.0 463201.0 464517.0 464585.0 464687.0 30130.4 30598.4 30997.8 31390.0 31580.4 52412.7 52593.7 53092.7 53281.0 53937.0 44735.6 45404.5 45598.5 45714.0 46657.3 43868.1 44720.0 44927.0 45808.0 45821.3 43685.0 43913.8 44318.6 44577.0 44698.0 38887.2 39176.8 39393.2 39418.0 39534.0 29657.9 29913.9 30137.8 30233.2 30529.5 08:01:02 INFO - PROCESS | 10502 | 08:01:02 INFO - PROCESS | 10502 | [#2] jquery.html Cycles:180 Average:32670.92 Median:35201.74 stddev:92292.70 (262.2%) stddev-sans-first:92519.85 08:01:02 INFO - PROCESS | 10502 | Values: 426.7 434.8 438.8 439.7 440.1 18635.6 19312.6 20284.1 20334.5 20409.5 16564.6 18720.9 19431.8 20177.8 20265.4 5881.6 6016.8 6050.4 6053.3 6062.5 5815.2 5893.7 5925.8 5978.4 5994.0 5874.9 5901.1 5909.3 5913.5 5918.7 5707.7 5810.4 5824.9 5870.4 5918.6 5131.2 5155.5 5167.0 5199.3 5200.0 22796.3 23502.5 23785.3 24134.3 24306.4 2145.0 2406.7 2485.9 2545.4 2680.6 10655.4 12264.7 15005.2 15480.0 15524.4 2093.2 2121.2 2234.3 2340.6 2382.7 83548.0 96576.0 97952.0 99292.0 103063.5 17362.7 18291.9 18441.2 18520.4 19121.3 35166.6 35236.8 35395.6 35433.6 35710.3 10669.7 11361.8 11432.2 11434.7 11458.8 9531.5 9588.4 9671.6 9681.5 9824.8 9269.7 9511.9 9589.5 9617.0 9664.9 3362.0 3605.4 3721.3 3750.2 3768.4 978.7 1005.2 1021.6 1061.0 1103.5 19461.0 19917.7 19960.5 20021.9 20116.9 1037.7 1058.3 1064.2 1099.0 1152.9 10834.6 11011.6 11114.9 11129.8 11242.7 552013.0 557944.0 564377.0 566657.0 567123.0 67620.0 83344.0 87266.0 98039.0 101324.5 962.9 992.2 992.9 995.3 1059.1 18048.7 18058.6 18105.5 18211.6 18470.4 41536.0 41771.6 41961.6 42942.4 44474.3 58698.7 60471.7 60740.0 61334.7 62032.0 7873.0 8229.0 8420.6 8503.9 9083.9 9784.0 13786.7 13883.4 13966.0 14217.9 6013.1 9600.5 11871.4 11987.5 12210.6 11978.4 12004.3 12083.3 12136.2 12666.6 12238.8 12358.3 12515.4 12692.6 12823.0 7877.8 8253.8 8464.4 8530.7 8753.9 12276.6 12373.5 12420.7 12421.1 12494.4 08:01:02 INFO - PROCESS | 10502 | 08:01:02 INFO - PROCESS | 10502 | [#3] mootools.html Cycles:180 Average:6143.73 Median:4757.19 stddev:3446.81 (72.5%) stddev-sans-first:3439.23 08:01:02 INFO - PROCESS | 10502 | Values: 1554.4 1600.7 1753.5 1868.7 1873.6 7843.4 9046.6 9267.1 9733.5 9852.5 9063.8 9314.2 9364.6 9381.8 9387.5 2489.2 2513.2 2529.8 2530.6 2533.0 2406.3 2453.5 2460.2 2461.6 2461.7 2417.9 2449.0 2456.8 2462.0 2464.0 2452.9 2464.1 2478.0 2502.4 2516.1 2393.8 2396.1 2398.5 2409.0 2470.0 9349.8 9355.6 9423.3 9432.0 9468.8 5415.7 5522.6 5523.7 5527.7 5533.0 3405.7 3472.8 3546.1 3562.3 3568.6 1063.4 1131.8 1132.8 1133.2 1137.6 12769.4 12833.3 12842.9 12843.2 12879.4 4846.2 4905.3 4958.4 5000.7 5035.2 10921.7 10970.8 11035.9 11072.6 11090.0 5417.9 5481.6 5505.7 5552.5 5568.5 4474.5 4967.3 5060.7 5220.8 5231.0 4291.2 4376.7 4412.1 4425.5 4533.8 1337.3 1398.5 1417.6 1422.1 1422.8 1002.6 1029.2 1039.1 1040.8 1043.5 6475.2 6573.6 6658.2 6664.1 6671.3 490.4 496.1 496.9 508.5 509.7 4420.2 4574.2 4600.1 4634.3 4668.2 10852.6 11027.9 11072.8 11113.8 11189.2 10904.7 11068.9 11122.4 11152.6 11164.4 8494.0 8501.2 8528.4 8660.6 8664.2 6249.9 6275.8 6381.0 6386.3 6396.6 10182.6 10217.6 10261.2 10274.9 10387.8 10394.6 10396.4 10414.2 10496.2 10556.3 8012.6 8054.4 8371.0 8378.9 8609.6 9259.2 9319.3 9441.6 9467.5 9468.4 8125.8 8132.6 8431.6 8443.7 8564.9 8309.6 8332.3 8374.9 8395.5 8397.4 7524.5 7573.0 7623.0 7637.2 7643.2 5695.0 5777.8 5842.2 5882.1 5894.7 5554.8 5686.0 5750.1 5861.2 5945.3 08:01:02 INFO - PROCESS | 10502 | 08:01:02 INFO - PROCESS | 10502 | [#4] prototype.html Cycles:180 Average:4943.65 Median:5581.69 stddev:1442.15 (25.8%) stddev-sans-first:1404.30 08:01:02 INFO - PROCESS | 10502 | Values: 345.7 348.5 349.9 357.3 358.2 5653.5 5797.6 5820.4 5899.8 5959.6 5719.7 5753.7 5775.7 5776.6 5794.6 4455.4 4483.0 4484.7 4495.2 4502.6 4437.0 4511.4 4519.9 4526.4 4548.2 4420.5 4472.0 4477.4 4480.6 4482.1 4471.3 4489.5 4507.4 4518.6 4536.0 3880.8 3922.9 3933.8 3976.9 3985.0 5561.3 5583.9 5593.2 5602.2 5645.3 5125.2 5145.9 5148.0 5189.2 5189.6 5970.0 6078.2 6107.0 6126.8 6138.9 4308.6 4329.4 4340.4 4360.7 4362.1 6189.3 6388.5 6418.9 6451.2 6462.3 4399.4 4399.8 4405.1 4421.2 4424.6 4483.2 4491.9 4509.4 4509.4 4512.5 5069.8 5126.6 5127.3 5134.2 5152.5 5903.4 5950.7 6106.7 6160.2 6168.2 1527.3 1553.6 1555.9 1558.2 1558.4 954.3 979.8 979.8 980.7 990.6 5289.3 5298.9 5303.7 5309.8 5315.8 5545.7 5588.4 5660.1 5668.3 5671.1 4961.7 5243.9 5266.9 5380.7 5387.2 3016.4 3038.3 3047.2 3052.2 3078.5 5522.6 5764.6 5776.3 5813.9 5838.7 5592.3 5627.6 5696.4 5705.3 5721.3 5708.5 5725.2 5759.4 5789.7 5793.5 5310.4 5545.8 5581.7 5581.7 5594.3 5433.4 5518.3 5541.4 5552.2 5566.4 5721.4 5749.8 5772.5 5772.6 5795.2 3857.7 4049.4 4083.9 4094.1 4097.5 5589.3 5608.7 5643.2 6161.4 6425.1 6215.0 6237.2 6243.0 6250.9 6252.3 6044.4 6155.6 6225.6 6230.4 6253.0 6103.7 6107.8 6114.7 6118.6 6140.6 6144.4 6214.3 6223.7 6238.5 6287.2 5836.6 6069.9 6131.6 6134.8 6135.4 08:01:02 INFO - PROCESS | 10502 | 08:01:02 INFO - PROCESS | 10502 | [#5] yui.html Cycles:180 Average:21006.27 Median:5161.49 stddev:29396.26 (569.5%) stddev-sans-first:29439.56 08:01:02 INFO - PROCESS | 10502 | Values: 796.5 799.9 860.8 870.1 898.4 15306.5 15325.1 15419.8 15671.8 16392.8 15935.2 16057.8 16147.9 16148.4 16185.5 745.6 850.9 876.9 878.6 879.8 859.0 865.1 866.8 868.4 868.7 916.7 921.6 922.1 922.5 922.9 910.6 912.2 916.4 917.9 919.7 672.3 676.7 677.5 677.9 679.7 13573.0 13602.3 13609.3 13679.0 13712.6 15749.4 16225.6 16373.1 16595.2 16668.3 13281.8 13290.0 13331.4 13401.9 13753.9 4170.6 4184.4 4234.8 4251.1 4266.8 75446.2 76291.6 76329.2 76428.0 76553.6 12474.7 12915.8 12962.5 12995.5 13154.2 23894.2 24030.2 24202.5 24219.4 24953.3 9210.8 9224.0 9237.5 9242.1 9388.6 5111.2 5232.7 5236.5 5264.6 5320.2 3634.4 3734.7 3748.2 3756.6 3763.5 543.8 605.9 614.7 615.3 615.6 665.3 771.4 792.7 827.3 828.0 11111.6 11233.7 11287.3 11585.8 11753.4 642.6 667.5 726.0 781.9 839.7 5211.8 5281.7 5326.6 5340.3 5408.5 72586.3 111412.0 111899.4 112997.0 118463.4 94785.5 95297.0 97666.0 98005.5 100529.5 88203.6 88354.0 88549.6 90877.5 92824.0 9149.6 9518.7 9554.7 9613.2 9854.8 52407.0 53202.0 53243.0 54149.5 54935.5 65776.0 76358.6 76808.5 79471.0 79997.0 12116.6 12547.4 13222.5 13490.4 13536.6 14022.4 14156.6 14229.9 14242.6 14284.6 12397.9 12709.9 12967.3 12988.0 13194.5 13796.4 13893.5 13919.9 14029.3 14070.3 13398.2 13558.7 13787.7 14004.6 14362.1 11485.8 11673.8 11710.7 11835.3 12000.6 10352.6 10394.3 10467.2 10487.3 11372.0 08:01:02 INFO - PROCESS | 10502 | -------- Summary: end -------- 08:01:02 INFO - PROCESS | 10502 | 08:01:03 INFO - TEST-INFO | 10502: exit 0 08:01:03 INFO - TEST-OK | dromaeo_css | took 1110904ms 08:01:03 INFO - TEST-START | kraken 08:01:03 INFO - operating with platform_type : linux_ 08:01:03 INFO - Initialising browser for kraken test... 08:01:03 INFO - TEST-INFO | started process 10740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg_WDnh/profile http://localhost:53518/getInfo.html) 08:01:07 INFO - PROCESS | 10740 | __metrics Screen width/height:1600/1200 08:01:07 INFO - PROCESS | 10740 | colorDepth:24 08:01:07 INFO - PROCESS | 10740 | Browser inner width/height: 1024/697 08:01:07 INFO - PROCESS | 10740 | __metrics 08:01:08 ERROR - PROCESS | 10740 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 08:01:09 INFO - TEST-INFO | 10740: exit 0 08:01:09 INFO - Browser initialized. 08:01:09 INFO - Running cycle 1/1 for kraken test... 08:01:09 INFO - TEST-INFO | started process 10869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg_WDnh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:21 INFO - PROCESS | 10869 | RSS: Main: 155652096 08:01:21 INFO - PROCESS | 10869 | 08:01:23 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53518/tests/kraken/driver.html?testName=audio-beat-detection) 08:01:24 INFO - PROCESS | 10869 | RSS: Main: 161673216 08:01:24 INFO - PROCESS | 10869 | 08:01:27 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53518/tests/kraken/driver.html?testName=audio-dft) 08:01:27 INFO - PROCESS | 10869 | RSS: Main: 160587776 08:01:27 INFO - PROCESS | 10869 | 08:01:30 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53518/tests/kraken/driver.html?testName=audio-fft) 08:01:31 INFO - PROCESS | 10869 | RSS: Main: 161730560 08:01:31 INFO - PROCESS | 10869 | 08:01:33 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53518/tests/kraken/driver.html?testName=audio-oscillator) 08:01:33 INFO - PROCESS | 10869 | RSS: Main: 161112064 08:01:33 INFO - PROCESS | 10869 | 08:01:36 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:01:36 INFO - PROCESS | 10869 | RSS: Main: 160587776 08:01:36 INFO - PROCESS | 10869 | 08:01:39 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53518/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:40 INFO - PROCESS | 10869 | RSS: Main: 160174080 08:01:40 INFO - PROCESS | 10869 | 08:01:43 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53518/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:44 INFO - PROCESS | 10869 | RSS: Main: 161427456 08:01:44 INFO - PROCESS | 10869 | 08:01:47 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53518/tests/kraken/driver.html?testName=json-parse-financial) 08:01:47 INFO - PROCESS | 10869 | RSS: Main: 161345536 08:01:47 INFO - PROCESS | 10869 | 08:01:49 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:49 INFO - PROCESS | 10869 | RSS: Main: 160944128 08:01:49 INFO - PROCESS | 10869 | 08:01:51 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:01:52 INFO - PROCESS | 10869 | RSS: Main: 160841728 08:01:52 INFO - PROCESS | 10869 | 08:01:54 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:01:55 INFO - PROCESS | 10869 | RSS: Main: 161357824 08:01:55 INFO - PROCESS | 10869 | 08:01:57 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:01:58 INFO - PROCESS | 10869 | RSS: Main: 161267712 08:01:58 INFO - PROCESS | 10869 | 08:02:00 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:02:01 INFO - PROCESS | 10869 | RSS: Main: 160935936 08:02:01 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53518/tests/kraken/driver.html?testName=ai-astar) 08:02:03 INFO - PROCESS | 10869 | RSS: Main: 161546240 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | __start_tp_report 08:02:03 INFO - PROCESS | 10869 | _x_x_mozilla_page_load 08:02:03 INFO - PROCESS | 10869 | _x_x_mozilla_page_load_details 08:02:03 INFO - PROCESS | 10869 | |i|pagename|runs| 08:02:03 INFO - PROCESS | 10869 | |0;ai-astar;113;104;111;110;109;111;109;108;110;108 08:02:03 INFO - PROCESS | 10869 | |1;audio-beat-detection;157;123;152;179;125;155;152;126;184;126 08:02:03 INFO - PROCESS | 10869 | |2;audio-dft;161;163;162;162;163;163;163;162;163;165 08:02:03 INFO - PROCESS | 10869 | |3;audio-fft;76;77;75;176;77;76;76;76;162;78 08:02:03 INFO - PROCESS | 10869 | |4;audio-oscillator;84;84;141;85;85;85;134;85;84;129 08:02:03 INFO - PROCESS | 10869 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;117;118 08:02:03 INFO - PROCESS | 10869 | |6;imaging-darkroom;147;146;147;146;146;148;148;147;147;147 08:02:03 INFO - PROCESS | 10869 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;96;95 08:02:03 INFO - PROCESS | 10869 | |8;json-parse-financial;52;52;53;56;54;57;53;56;53;54 08:02:03 INFO - PROCESS | 10869 | |9;json-stringify-tinderbox;60;60;60;60;60;60;60;60;59;60 08:02:03 INFO - PROCESS | 10869 | |10;stanford-crypto-aes;76;83;76;83;76;77;78;78;107;82 08:02:03 INFO - PROCESS | 10869 | |11;stanford-crypto-ccm;127;119;121;118;119;116;127;125;122;129 08:02:03 INFO - PROCESS | 10869 | |12;stanford-crypto-pbkdf2;157;155;156;156;154;155;156;158;155;155 08:02:03 INFO - PROCESS | 10869 | |13;stanford-crypto-sha256-iterative;62;64;62;62;62;65;61;61;61;61 08:02:03 INFO - PROCESS | 10869 | __end_tp_report 08:02:03 INFO - PROCESS | 10869 | __start_cc_report 08:02:03 INFO - PROCESS | 10869 | _x_x_mozilla_cycle_collect,868 08:02:03 INFO - PROCESS | 10869 | __end_cc_report 08:02:03 INFO - PROCESS | 10869 | __startTimestamp1467039723356__endTimestamp 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | ------- Summary: start ------- 08:02:03 INFO - PROCESS | 10869 | Number of tests: 14 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.41 (2.2%) stddev-sans-first:2.15 08:02:03 INFO - PROCESS | 10869 | Values: 113.0 104.0 111.0 110.0 109.0 111.0 109.0 108.0 110.0 108.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:153.50 stddev:22.46 (14.6%) stddev-sans-first:23.58 08:02:03 INFO - PROCESS | 10869 | Values: 157.0 123.0 152.0 179.0 125.0 155.0 152.0 126.0 184.0 126.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:0.93 08:02:03 INFO - PROCESS | 10869 | Values: 161.0 163.0 162.0 162.0 163.0 163.0 163.0 162.0 163.0 165.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:39.20 (51.6%) stddev-sans-first:40.98 08:02:03 INFO - PROCESS | 10869 | Values: 76.0 77.0 75.0 176.0 77.0 76.0 76.0 76.0 162.0 78.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#4] audio-oscillator Cycles:10 Average:99.60 Median:84.50 stddev:24.37 (28.8%) stddev-sans-first:25.18 08:02:03 INFO - PROCESS | 10869 | Values: 84.0 84.0 141.0 85.0 85.0 85.0 134.0 85.0 84.0 129.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 08:02:03 INFO - PROCESS | 10869 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:02:03 INFO - PROCESS | 10869 | Values: 147.0 146.0 147.0 146.0 146.0 148.0 148.0 147.0 147.0 147.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:02:03 INFO - PROCESS | 10869 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.76 (3.3%) stddev-sans-first:1.72 08:02:03 INFO - PROCESS | 10869 | Values: 52.0 52.0 53.0 56.0 54.0 57.0 53.0 56.0 53.0 54.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 08:02:03 INFO - PROCESS | 10869 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 59.0 60.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:78.00 stddev:9.37 (12.0%) stddev-sans-first:9.72 08:02:03 INFO - PROCESS | 10869 | Values: 76.0 83.0 76.0 83.0 76.0 77.0 78.0 78.0 107.0 82.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:123.50 stddev:4.45 (3.6%) stddev-sans-first:4.38 08:02:03 INFO - PROCESS | 10869 | Values: 127.0 119.0 121.0 118.0 119.0 116.0 127.0 125.0 122.0 129.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 08:02:03 INFO - PROCESS | 10869 | Values: 157.0 155.0 156.0 156.0 154.0 155.0 156.0 158.0 155.0 155.0 08:02:03 INFO - PROCESS | 10869 | 08:02:03 INFO - PROCESS | 10869 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.37 (2.2%) stddev-sans-first:1.45 08:02:03 INFO - PROCESS | 10869 | Values: 62.0 64.0 62.0 62.0 62.0 65.0 61.0 61.0 61.0 61.0 08:02:03 INFO - PROCESS | 10869 | -------- Summary: end -------- 08:02:03 INFO - PROCESS | 10869 | 08:02:04 INFO - TEST-INFO | 10869: exit 0 08:02:04 INFO - TEST-OK | kraken | took 61221ms 08:02:04 INFO - SUITE-END | took 1172s 08:02:04 INFO - Completed test suite (00:19:32) 08:02:04 INFO - javascript benchmark 08:02:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7796.658402469993, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3443.5523381960343, 3493.47597860321, 3511.28018756155, 3526.365254254233, 3547.627499112593, 5870.530357571395, 5883.88232235355, 5901.675407852572, 5964.194833697449, 5994.190784244126, 5972.462478376945, 6010.939890601093, 6012.038073908176, 6016.7593296268205, 6029.819105426834, 5246.370435547739, 5294.444083371249, 5377.3009508764, 5399.919001214985, 5422.15956526739, 5254.080535906221, 5300.09898317285, 5323.494268044549, 5383.246345511631, 5392.595555333346, 5369.62412631116, 5384.461553844623, 5401.972990135044, 5410.134378499441, 5413.079776437995, 5356.54469370104, 5369.999999999981, 5465.480779325958, 5465.961467321196, 5467.0705979983495, 5348.064088784486, 5351.090314646481, 5352.197170424429, 5382.515573598355, 5434.565234781247, 5547.44525547446, 5674.716264186815, 5699.373068962411, 5739.053056245714, 5802.12968054791, 6329.8417539561415, 6332.905006424908, 6341.080543321239, 6346.238451385863, 6369.8407539811415, 6153.261608606951, 6378.298387177407, 6401.423871851509, 6413.1662883825275, 6414.903776443311, 5794.62334948227, 5831.387704291031, 5892.764289428461, 5931.525477961753, 5947.6431414115295, 6477.805665829938, 6523.151990241333, 6550.541462097607, 6601.801945941629, 6608.306127856602, 6127.448529632355, 6132.908006379907, 6251.187345645037, 6308.905366419507, 6316.9368306317265, 6333.2400111985935, 6338.58799178052, 6355.5551111421755, 6371.076193951851, 6395.232572091379, 6310.5267104967315, 6337.619742815354, 6353.491720662429, 6361.045843123568, 6363.33185015576, 6132.478739307119, 6172.722227499773, 6172.814815555541, 6239.06414037898, 6350.8412289692205, 4759.119562880878, 4771.618270538349, 4772.689775164673, 4792.904141917142, 4793.688410253322, 4242.215190189763, 4262.42457268271, 4282.272013757669, 4293.0, 4306.0, 5977.432143946318, 6006.849828754316, 6010.639361638316, 6037.607555508878, 6093.390660933871, 6143.235544005215, 6238.438540531374, 6280.466160376419, 6294.65379404128, 6394.712237949303, 5890.941090589039, 6073.787417440369, 6077.209962704908, 6085.847853803691, 6090.177825993434, 5241.397239317527, 5266.947330526646, 5313.362396512366, 5345.893082138336, 5350.063738845764, 6537.836554086186, 6540.149780528596, 6573.605583664996, 6574.145361103026, 6602.60384376939, 6060.363661815622, 6262.655553944577, 6311.936880631319, 6325.96837015812, 6353.618782873043, 6474.482041436768, 6555.770548030796, 6570.441512471493, 6680.933190668031, 6686.665666716547, 6282.371762823681, 6345.333739957423, 6347.619142851444, 6358.650274234961, 6358.713857876314, 6176.042713379434, 6260.843478913063, 6425.967870160619, 6433.935660643334, 6436.613803171825, 6124.960759790135, 6204.441600255998, 6217.222847144107, 6230.626162430269, 6235.875282494234, 6147.139400484025, 6210.037444196157, 6215.12988181664, 6222.782202622887, 6233.158523599437, 5918.852028699144, 6052.909206361996, 6062.393760623902, 6099.542534309856, 6134.754609815557, 6258.092576576462, 6269.905951410641, 6274.309825919237, 6296.5592408530965, 6296.716647750771, 6185.969070154621, 6200.3799620037635, 6207.255129384503, 6210.72051757681, 6212.06818977157], "value": 5833.880908864944, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.9725962331695, 663.4592806862407, 672.3612568060344, 680.4318394140892, 683.627423054435, 45828.0, 46707.76646116769, 47150.76424617876, 47200.58398248049, 50483.24275135876, 47664.52335476644, 48021.279680804815, 48238.75880620601, 48328.0, 48386.75806620962, 9084.909150908488, 9196.03441638625, 9218.907810921872, 9224.169824715775, 9256.398334108295, 9045.0, 9165.0, 9180.44917304964, 9181.632734690604, 9193.586288616994, 9158.404703694272, 9190.35667503275, 9216.400933939307, 9239.399439036475, 9242.86135707965, 9068.138526839972, 9095.363324567283, 9141.908580914205, 9154.130357616015, 9172.770680732969, 9098.499582522958, 9111.772205694844, 9122.22461090808, 9160.450372977642, 9185.17333439987, 44109.77945110286, 44399.778001109786, 44425.33361999573, 44446.11107777859, 44505.0, 4010.6791456683395, 4103.958960410388, 4514.142312960527, 4579.656525760582, 4617.792199351004, 33526.0, 34006.31987360239, 34057.31885362304, 34131.82934085339, 35312.64687353145, 4324.200022995725, 4369.650427965755, 4407.118576284756, 4408.58118478744, 4420.762186587728, 383529.0, 384544.0, 385081.0, 385366.0, 386909.0654546737, 62607.37392626015, 62927.37072629307, 62943.0, 62958.685206573675, 63061.36938630647, 38699.2260154801, 39519.0, 39552.60447395547, 41339.37990930139, 41442.792786035876, 19461.805381946284, 19560.315388961317, 19573.902130489256, 19616.0, 19634.21463141487, 15005.474808381872, 15141.848581514265, 15184.316705748268, 15205.163715995726, 15213.391464341303, 21278.78721212799, 21339.14643414277, 21484.248051318442, 21516.569668606855, 21604.0, 7571.46999710026, 7659.808504787314, 7761.0, 7824.37405007598, 7963.496061732819, 1079.5681727309138, 1088.7985722641338, 1095.7921581128346, 1114.9554017839357, 1228.0789407944042, 33151.502727459105, 33179.83410082934, 33346.3330733384, 33653.0, 34145.31709365849, 1119.4626579241847, 1177.9941100294616, 1211.6910187902029, 1231.4027696567157, 1277.9680507987375, 17211.139443027798, 17362.21870015827, 17673.558161046076, 17796.199171037075, 18052.368167114088, 586640.0, 588135.0, 588326.0, 591491.0, 596557.0, 64053.35946640567, 64711.0, 64920.35079649238, 65069.349306507276, 65225.34774652288, 1472.0632338484577, 1487.7247709173837, 1493.611660968156, 1503.796987406708, 1516.696660667871, 31943.520847187774, 32272.193195170308, 32380.514292285163, 33075.50386744153, 33391.165220869676, 54320.45679543312, 54543.0, 54680.45319546913, 54701.72649136729, 54991.725041374535, 459278.0, 463201.0, 464517.0, 464585.0, 464687.0, 30130.397392052473, 30598.388032239676, 30997.845010774803, 31390.0, 31580.368392632477, 52412.7379363116, 52593.7370313146, 53092.73453632707, 53281.0, 53937.0, 44735.55264447444, 45404.54595454003, 45598.54401456076, 45714.0, 46657.30014049724, 43868.122637547705, 44720.0, 44927.0, 45808.0, 45821.31268030916, 43685.0, 43913.78043109764, 44318.556814431446, 44577.0, 44698.0, 38887.22225555417, 39176.80411597924, 39393.2121357577, 39418.0, 39534.0, 29657.85171074131, 29913.85043074771, 30137.849310753307, 30233.244168895955, 30529.542056868722], "value": 21485.364766465264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.7284482331857, 434.819549886797, 438.79595987865633, 439.7449479302005, 440.1263491968443, 18635.62728745424, 19312.613747725056, 20284.087216075313, 20334.491637709045, 20409.48976275594, 16564.585885352873, 18720.906395468002, 19431.805681943177, 20177.78933264005, 20265.39203823884, 5881.558883083764, 6016.8495787605225, 6050.42520960508, 6053.303870054956, 6062.514998800108, 5815.156802263669, 5893.673923367251, 5925.822225333247, 5978.40215978403, 5993.970030149843, 5874.9412505874825, 5901.05583106703, 5909.290885093795, 5913.497352725002, 5918.674472903988, 5707.686077265748, 5810.389909059572, 5824.912626310566, 5870.354261031283, 5918.615290006136, 5131.204663277198, 5155.484451554815, 5166.974165129188, 5199.324087868553, 5199.974000129975, 22796.316110516713, 23502.529949401087, 23785.286441406784, 24134.275971720876, 24306.392340191636, 2145.0, 2406.6991626046743, 2485.8632775197357, 2545.4145546524405, 2680.597910313449, 10655.413952232624, 12264.693382665415, 15005.24973751308, 15480.0, 15524.379024838992, 2093.16273490605, 2121.2151503943487, 2234.2961966980347, 2340.578695834749, 2382.749811269809, 83548.0, 96576.03423965741, 97952.0, 99292.0, 103063.48468257686, 17362.746127198665, 18291.908540457214, 18441.1701473434, 18520.444386668423, 19121.330753423565, 35166.648333516336, 35236.82381588076, 35395.64604353975, 35433.64566354355, 35710.28579428397, 10669.733256668645, 11361.829572556418, 11432.199746017699, 11434.656960291204, 11458.77082458363, 9531.475768832643, 9588.37675551087, 9671.564779584936, 9681.51592420376, 9824.803503930025, 9269.655899894478, 9511.90488095124, 9589.520523973773, 9616.95191524038, 9664.855027174597, 3362.0, 3605.441156620728, 3721.348763966295, 3750.212455384345, 3768.4347347897487, 978.7259567321162, 1005.1657124586576, 1021.6475316015963, 1060.984085238722, 1103.5089385223498, 19461.0, 19917.701234481494, 19960.500987475138, 20021.899890500456, 20116.89941550312, 1037.6886933919793, 1058.25921854702, 1064.1752641702742, 1099.0, 1152.8847115288572, 10834.566617335377, 11011.559537618567, 11114.944425277983, 11129.833052504218, 11242.718932026764, 552013.0, 557944.0, 564377.0, 566657.0, 567123.0, 67620.0, 83344.0, 87266.0, 98039.0, 101324.49337753412, 962.9037096290455, 992.2310209587628, 992.9354591951644, 995.348047029197, 1059.078601616583, 18048.729269061238, 18058.645601580196, 18105.547361316072, 18211.635767284315, 18470.353537626117, 41536.0, 41771.582284176766, 41961.64602476979, 42942.35586466268, 44474.332885007396, 58698.70650646719, 60471.69764151151, 60740.0, 61334.69332653308, 62032.0, 7873.0, 8228.958855205685, 8420.5789710513, 8503.872441913252, 9083.863742043743, 9784.02159784016, 13786.724265514433, 13883.39305381816, 13966.0, 14217.928910355797, 6013.067974463965, 9600.519974001132, 11871.397361356107, 11987.520499179935, 12210.633680989584, 11978.401079946143, 12004.339761313211, 12083.335416552174, 12136.211146275464, 12666.556670516487, 12238.75522489563, 12358.320292384005, 12515.4368053436, 12692.619221423372, 12823.0, 7877.7636670899965, 8253.79365515867, 8464.407491475784, 8530.74407767768, 8753.91246087531, 12276.570320038756, 12373.505059797508, 12420.689482763004, 12421.130520863453, 12494.37528123572], "value": 10429.287050649427, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1554.3860175230789, 1600.735878580034, 1753.4564285071629, 1868.729034290028, 1873.5597134673358, 7843.411744119186, 9046.638134474613, 9267.119623635752, 9733.464659443736, 9852.458114803683, 9063.773405664862, 9314.208292295147, 9364.578593963271, 9381.81236375272, 9387.530623468834, 2489.1785710715512, 2513.183215454975, 2529.810264230181, 2530.5571524983147, 2533.0121252711456, 2406.338256979327, 2453.472503411766, 2460.151247819508, 2461.59383701689, 2461.716902556202, 2417.9153729619466, 2449.0448724997264, 2456.7666071723156, 2461.9876900615473, 2463.950720985579, 2452.852828830258, 2464.125235541375, 2478.033566908916, 2502.3744063984004, 2516.081630204971, 2393.772591603795, 2396.113438027941, 2398.5442765874427, 2408.9879550602136, 2470.049031123013, 9349.813003739888, 9355.625774968994, 9423.34036617437, 9431.952840235756, 9468.763280917963, 5415.675059496442, 5522.641028333145, 5523.6685798852195, 5527.695976721278, 5533.031719449121, 3405.6594340565744, 3472.7742696724886, 3546.060294022086, 3562.305350456662, 3568.6431356864364, 1063.3885515828429, 1131.7736452709491, 1132.7847708935276, 1133.2010932292796, 1137.6075254037344, 12769.361531923367, 12833.294168820712, 12842.9357853212, 12843.165194262436, 12879.356032198446, 4846.151923413388, 4905.288733133676, 4958.42978057528, 5000.74996250186, 5035.16919708244, 10921.672349829518, 10970.780584388267, 11035.8964103589, 11072.612458563912, 11090.001899829054, 5417.864553386197, 5481.588880833953, 5505.697186654692, 5552.5280351169795, 5568.52667523257, 4474.530174331649, 4967.254911763264, 5060.7216603086445, 5220.817271395483, 5231.0, 4291.206126866539, 4376.671749618791, 4412.0955204183065, 4425.491068527161, 4533.77331133442, 1337.3046016071783, 1398.5175114585452, 1417.6030711400824, 1422.1253928833694, 1422.7581311177125, 1002.644061358222, 1029.1509504658536, 1039.095986491757, 1040.765827688764, 1043.4678314059884, 6475.222973243241, 6573.57271777333, 6658.167729033871, 6664.067030615718, 6671.299513551105, 490.40415894688124, 496.0599663637387, 496.92794544791525, 508.461031306816, 509.72220140023774, 4420.171090502081, 4574.176648203355, 4600.056988317387, 4634.304854271886, 4668.229742092517, 10852.620158294421, 11027.889721102687, 11072.833907491395, 11113.83329250062, 11189.160812939062, 10904.672859814218, 11068.944655276833, 11122.44387780624, 11152.553897843994, 11164.385958772345, 8493.957530212432, 8501.234888860032, 8528.40301178924, 8660.610272537751, 8664.220220180214, 6249.875002500015, 6275.811725648238, 6380.968095159495, 6386.297507274289, 6396.552241343062, 10182.592696292066, 10217.642382516577, 10261.17910567138, 10274.897251027693, 10387.844182337421, 10394.58421663125, 10396.428196449267, 10414.166866650801, 10496.160307175254, 10556.261061725605, 8012.559309238048, 8054.436189466681, 8370.958145209235, 8378.916210838057, 8609.612567434606, 9259.212966897889, 9319.30105242096, 9441.622335106793, 9467.526623668651, 9468.384555003902, 8125.837483250184, 8132.552709600792, 8431.620577073923, 8443.66225350979, 8564.914350856412, 8309.626066827128, 8332.291755200877, 8374.916250837414, 8395.496270223806, 8397.412181147261, 7524.473286869867, 7573.0, 7623.047119110111, 7637.198094200251, 7643.235676432535, 5695.0, 5777.826665200051, 5842.152887831326, 5882.117682347511, 5894.705264736832, 5554.805581804618, 5685.971570142123, 5750.079987202028, 5861.1794348792055, 5945.256842894638], "value": 4853.117983794123, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.6871531264205, 348.4738045551218, 349.91252186953255, 357.30682475996565, 358.2315932325161, 5653.4911857932775, 5797.594168408213, 5820.417958204177, 5899.823005309837, 5959.6424214547105, 5719.742611582478, 5753.65478071316, 5775.67898458387, 5776.59563830532, 5794.565407594426, 4455.398521199629, 4482.97758511207, 4484.708493947883, 4495.235809912323, 4502.639788816903, 4437.0, 4511.4135162429, 4519.909601807962, 4526.366308716782, 4548.226801443746, 4420.469543654766, 4472.0, 4477.3731677565165, 4480.596746292833, 4482.148391805563, 4471.262241730111, 4489.506154323039, 4507.408240261862, 4518.644406677983, 4535.954640453586, 3880.8447662093763, 3922.882313530599, 3933.7639741615594, 3976.940345894785, 3985.0, 5561.304836895388, 5583.944160558423, 5593.188987596816, 5602.159676048625, 5645.294338207724, 5125.154349532323, 5145.948540514584, 5148.04374337753, 5189.221616757479, 5189.610779191576, 5970.0, 6078.209832721762, 6107.0228763397645, 6126.816195514097, 6138.938610613882, 4308.633766129883, 4329.415528903589, 4340.392345071693, 4360.716553424018, 4362.149380870732, 6189.257289125334, 6388.520860935402, 6418.8716225675225, 6451.1936007999, 6462.32145624712, 4399.428074350378, 4399.780010999501, 4405.118976204772, 4421.248387774086, 4424.579664931826, 4483.193025255486, 4491.887702807456, 4509.391232183679, 4509.444241736595, 4512.548745125461, 5069.8479045627955, 5126.564242039394, 5127.307813445212, 5134.204198349262, 5152.4847515248175, 5903.3801450847905, 5950.732217050243, 6106.664133472613, 6160.199174107427, 6168.2242990653485, 1527.2745445913324, 1553.6193632560096, 1555.9066456012677, 1558.1741676911256, 1558.4000159938505, 954.3033585482636, 979.7893452907516, 979.8138353712772, 980.7302991677345, 990.64336838738, 5289.259503669489, 5298.92051619226, 5303.681779093266, 5309.814156504581, 5315.840524784263, 5545.724483368767, 5588.385277619459, 5660.122680984454, 5668.26312579362, 5671.071835575842, 4961.6526843121355, 5243.868903277372, 5266.894662106736, 5380.704061276668, 5387.24578559002, 3016.441958237689, 3038.255627371264, 3047.207725991258, 3052.206426329126, 3078.5228289615147, 5522.587253825341, 5764.625299355528, 5776.277965254343, 5813.941860581424, 5838.67887266196, 5592.3009623797025, 5627.606067575231, 5696.430356964271, 5705.288413475941, 5721.284839395075, 5708.514776243983, 5725.249961275371, 5759.395263497357, 5789.710514474175, 5793.536517078624, 5310.362756469249, 5545.833624991256, 5581.665100094007, 5581.711498285684, 5594.300712410949, 5433.429489903503, 5518.344496651069, 5541.418151094238, 5552.167174923794, 5566.415526369673, 5721.427857214412, 5749.8275051748515, 5772.480476757112, 5772.585716499484, 5795.24661793981, 3857.672097871712, 4049.4128351388295, 4083.8570650027104, 4094.1402305514985, 4097.467329247179, 5589.301337332833, 5608.663480191201, 5643.209950606836, 6161.4146656067605, 6425.10048593188, 6215.0, 6237.1891654084675, 6243.001119820807, 6250.9062364065485, 6252.280987686474, 6044.395560444096, 6155.630662160284, 6225.626462412089, 6230.408111229426, 6253.0, 6103.664298463627, 6107.84730381744, 6114.6636934969, 6118.571699980958, 6140.556969112345, 6144.38556144382, 6214.25428948529, 6223.688815559294, 6238.532110091671, 6287.245530536182, 5836.649801011953, 6069.908951365821, 6131.620385413246, 6134.846628834315, 6135.386461354007], "value": 4483.2049784386645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.4663675337526, 799.9040115186175, 860.832137733142, 870.1168314161132, 898.4384759525296, 15306.540803775877, 15325.080495170283, 15419.845801541982, 15671.84328156718, 16392.83607163928, 15935.20323983802, 16057.759133613004, 16147.91926040371, 16148.434804781835, 16185.514434566981, 745.634639026877, 850.9106543812873, 876.9035406105323, 878.5607196401799, 879.7844528090627, 859.0, 865.126222515261, 866.7919699272193, 868.3617541107282, 868.7176667583029, 916.7295647783919, 921.5622579274824, 922.1009515722184, 922.5479515037616, 922.9261659067292, 910.5993362920294, 912.1744820937063, 916.4043371808344, 917.857732051533, 919.6919032124247, 672.2806596941275, 676.719161547957, 677.485111315399, 677.861038487109, 679.7281087564965, 13573.0, 13602.31988400586, 13609.251491167981, 13679.0, 13712.588622341245, 15749.370025198978, 16225.59436014109, 16373.09947952862, 16595.17024148788, 16668.33326666932, 13281.800772988412, 13290.0, 13331.400086996011, 13401.932990335083, 13753.862461375358, 4170.582941705805, 4184.407357657276, 4234.788260586989, 4251.149770046003, 4266.765327906964, 75446.24553754447, 76291.61854190694, 76329.23670763276, 76428.0, 76553.61723191405, 12474.688132796753, 12915.806262906064, 12962.546310879263, 12995.545155919686, 13154.21074735519, 23894.163704270613, 24030.158944436862, 24202.515949680906, 24219.39451513726, 24953.251402457954, 9210.81578368429, 9223.953880230556, 9237.474064587885, 9242.07579242084, 9388.57751401175, 5111.207762796773, 5232.686038837682, 5236.476352364733, 5264.578833693296, 5320.201969704575, 3634.3821550336506, 3734.6638802507905, 3748.2128752962185, 3756.586775454698, 3763.49192858966, 543.7960764713232, 605.9394060593905, 614.671150934248, 615.2647586134616, 615.5937081526171, 665.3346653346654, 771.4214339245566, 792.6512334572769, 827.2802661684373, 828.035338830256, 11111.55553777856, 11233.660333212621, 11287.266327688674, 11585.768284634429, 11753.353565553805, 642.6208536963214, 667.4760313154151, 725.9963700181571, 781.878808784628, 839.6641343462663, 5211.765470553834, 5281.663947312293, 5326.6005049621435, 5340.332458442695, 5408.486193811582, 72586.27413725795, 111412.0, 111899.44050279696, 112997.0, 118463.40768296276, 94785.52607236919, 95297.0, 97666.0, 98005.50997244968, 100529.49735251277, 88203.55898220467, 88354.0, 88549.55725221461, 90877.54561227284, 92824.0, 9149.63401463934, 9518.737868909626, 9554.713358599252, 9613.182879455046, 9854.753631159278, 52407.0, 53202.0, 53243.0, 54149.45850541444, 54935.45064549303, 65776.0, 76358.6182069086, 76808.46383072196, 79471.0, 79997.0, 12116.575919842764, 12547.43536540876, 13222.537211197561, 13490.392932318266, 13536.59390218295, 14022.368993395527, 14156.575302740934, 14229.857701422854, 14242.643933901736, 14284.642883927569, 12397.93801030989, 12709.872901270868, 12967.286799225756, 12988.0, 13194.472221111047, 13796.448142074205, 13893.513727019506, 13919.904719368524, 14029.298535073001, 14070.296485175904, 13398.196108233537, 13558.728825423634, 13787.655308616964, 14004.579862604138, 14362.066465679698, 11485.770284594095, 11673.766524669629, 11710.70723231926, 11835.349055802013, 12000.63998080059, 10352.585896564053, 10394.272400931863, 10467.214958877963, 10487.318324308895, 11372.0], "value": 7896.656649726013, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1509.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 111.0, 110.0, 109.0, 111.0, 109.0, 108.0, 110.0, 108.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 152.0, 179.0, 125.0, 155.0, 152.0, 126.0, 184.0, 126.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 163.0, 163.0, 163.0, 162.0, 163.0, 165.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 176.0, 77.0, 76.0, 76.0, 76.0, 162.0, 78.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 141.0, 85.0, 85.0, 85.0, 134.0, 85.0, 84.0, 129.0], "value": 99.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 56.0, 54.0, 57.0, 53.0, 56.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 76.0, 83.0, 76.0, 77.0, 78.0, 78.0, 107.0, 82.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 119.0, 121.0, 118.0, 119.0, 116.0, 127.0, 125.0, 122.0, 129.0], "value": 122.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 156.0, 156.0, 154.0, 155.0, 156.0, 158.0, 155.0, 155.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 62.0, 62.0, 65.0, 61.0, 61.0, 61.0, 61.0], "value": 62.1, "unit": "score"}]}]} 08:02:04 INFO - Return code: 0 08:02:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:02:04 ERROR - # TBPL SUCCESS # 08:02:04 INFO - Running post-action listener: _resource_record_post_action 08:02:04 INFO - ##### 08:02:04 INFO - ##### Finished run-tests step (success) 08:02:04 INFO - ##### 08:02:04 INFO - Running post-run listener: _resource_record_post_run 08:02:04 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 274432; Write bytes: 486928384; Read time: 224; Write time: 441480 08:02:04 INFO - TinderboxPrint: CPU usage
13.5% 08:02:04 INFO - TinderboxPrint: I/O read bytes / time
274,432 / 224 08:02:04 INFO - TinderboxPrint: I/O write bytes / time
486,928,384 / 441,480 08:02:04 INFO - TinderboxPrint: CPU idle
8,207.0 (86.5%) 08:02:04 INFO - TinderboxPrint: CPU user
1,219.2 (12.9%) 08:02:04 INFO - TinderboxPrint: Swap in / out
0 / 0 08:02:04 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 129490944; Read time: 0; Write time: 176428 08:02:04 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 270336; Write bytes: 251232256; Read time: 88; Write time: 170708 08:02:05 INFO - Running post-run listener: _upload_blobber_files 08:02:05 INFO - Blob upload gear active. 08:02:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:02:05 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 08:02:05 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'] 08:02:05 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 08:02:05 INFO - (blobuploader) - INFO - Open directory for files ... 08:02:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:02:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:02:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:06 INFO - (blobuploader) - INFO - Done attempting. 08:02:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:02:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:02:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:07 INFO - (blobuploader) - INFO - Done attempting. 08:02:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:02:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:02:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:11 INFO - (blobuploader) - INFO - Done attempting. 08:02:11 INFO - (blobuploader) - INFO - Iteration through files over. 08:02:11 INFO - Return code: 0 08:02:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:02:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:02:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/908eab7ebe42dbf4139210970cf5a0c274baed1a69e38e2c4f5ed7e46d59c75cd7356272c5c7c23790e412b5ec6ee98de8470bda2d1300aa9076e394710ee46d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45597c087f013b4c887c57ef7292167142801afc5f77c784eef7826756fb27ee646013fe21223f64de6b79d0623aa8613bb38ccfa7b0d4b3ff579631225544fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48ef457bdced9048055778f3982aa30c2eaf1158b5fc169334c8ea4e58f32508edeed4dd0d26453c348eadf4b7e21e29d0c7453b02ffe66a8888fbbf10cdb027"} 08:02:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:02:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:02:11 INFO - Contents: 08:02:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/908eab7ebe42dbf4139210970cf5a0c274baed1a69e38e2c4f5ed7e46d59c75cd7356272c5c7c23790e412b5ec6ee98de8470bda2d1300aa9076e394710ee46d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45597c087f013b4c887c57ef7292167142801afc5f77c784eef7826756fb27ee646013fe21223f64de6b79d0623aa8613bb38ccfa7b0d4b3ff579631225544fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48ef457bdced9048055778f3982aa30c2eaf1158b5fc169334c8ea4e58f32508edeed4dd0d26453c348eadf4b7e21e29d0c7453b02ffe66a8888fbbf10cdb027"} 08:02:11 INFO - Running post-run listener: copy_logs_to_upload_dir 08:02:11 INFO - Copying logs to upload dir... 08:02:11 INFO - mkdir: /builds/slave/test/build/upload/logs 08:02:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.926554 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-27 08:02:10.964195) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:02:10.968112) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007 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/908eab7ebe42dbf4139210970cf5a0c274baed1a69e38e2c4f5ed7e46d59c75cd7356272c5c7c23790e412b5ec6ee98de8470bda2d1300aa9076e394710ee46d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45597c087f013b4c887c57ef7292167142801afc5f77c784eef7826756fb27ee646013fe21223f64de6b79d0623aa8613bb38ccfa7b0d4b3ff579631225544fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48ef457bdced9048055778f3982aa30c2eaf1158b5fc169334c8ea4e58f32508edeed4dd0d26453c348eadf4b7e21e29d0c7453b02ffe66a8888fbbf10cdb027"} build_url:https://queue.taskcluster.net/v1/task/VHhHmwbsSX-cX5x6kx1GUw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011513 build_url: 'https://queue.taskcluster.net/v1/task/VHhHmwbsSX-cX5x6kx1GUw/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/908eab7ebe42dbf4139210970cf5a0c274baed1a69e38e2c4f5ed7e46d59c75cd7356272c5c7c23790e412b5ec6ee98de8470bda2d1300aa9076e394710ee46d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45597c087f013b4c887c57ef7292167142801afc5f77c784eef7826756fb27ee646013fe21223f64de6b79d0623aa8613bb38ccfa7b0d4b3ff579631225544fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48ef457bdced9048055778f3982aa30c2eaf1158b5fc169334c8ea4e58f32508edeed4dd0d26453c348eadf4b7e21e29d0c7453b02ffe66a8888fbbf10cdb027"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:02:10.996010) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:02:10.996408) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467038450.513307-201836007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004359 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:02:11.081244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:02:11.081617) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:02:11.082186) ========= ========= Total master_lag: 0.18 =========