builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1470048029.71 results: success (0) buildid: 20160731234823 builduid: ac593188bfc9435eb9125393ed1fd078 revision: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:29.709609) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:29.710156) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:29.710562) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:29.783569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:29.783854) ========= 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=c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 03:40: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% 46.5M=0s 2016-08-01 03:40:30 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084053 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:29.899787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:29.900120) ========= 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=c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019721 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:29.958579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:29.959063) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 03:40:30,290 truncating revision to first 12 chars 2016-08-01 03:40:30,290 Setting DEBUG logging. 2016-08-01 03:40:30,290 attempt 1/10 2016-08-01 03:40:30,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fcdf4bb70356?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 03:40:30,773 unpacking tar archive at: mozilla-aurora-fcdf4bb70356/testing/mozharness/ program finished with exit code 0 elapsedTime=0.821639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:30.797124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:30.797441) ========= script_repo_revision: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:30.797854) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:30.798195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 03:40:30.809037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-01 03:40:30.809351) ========= /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=c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:40:31 INFO - MultiFileLogger online at 20160801 03:40:31 in /builds/slave/test 03:40: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 03:40:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:40:31 INFO - {'append_to_log': False, 03:40:31 INFO - 'base_work_dir': '/builds/slave/test', 03:40:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:40:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:40:31 INFO - 'branch': 'Mozilla-Aurora', 03:40:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:40:31 INFO - 'config_files': ('talos/linux_config.py',), 03:40:31 INFO - 'default_actions': ('clobber', 03:40:31 INFO - 'read-buildbot-config', 03:40:31 INFO - 'download-and-extract', 03:40:31 INFO - 'populate-webroot', 03:40:31 INFO - 'create-virtualenv', 03:40:31 INFO - 'install', 03:40:31 INFO - 'run-tests'), 03:40:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:40:31 INFO - 'download_minidump_stackwalk': True, 03:40:31 INFO - 'download_symbols': 'ondemand', 03:40:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:40:31 INFO - 'tooltool.py': '/tools/tooltool.py', 03:40:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:40:31 INFO - '/tools/misc-python/virtualenv.py')}, 03:40:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:40:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:40:31 INFO - 'installer_path': 'installer.exe', 03:40:31 INFO - 'log_level': 'info', 03:40:31 INFO - 'log_name': 'talos', 03:40:31 INFO - 'log_to_console': True, 03:40:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:40:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:40:31 INFO - 'opt_config_files': (), 03:40:31 INFO - 'pip_index': False, 03:40:31 INFO - 'sps_profile': False, 03:40:31 INFO - 'sps_profile_interval': 0, 03:40:31 INFO - 'suite': 'dromaeojs-e10s', 03:40:31 INFO - 'system_bits': '32', 03:40:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:40:31 INFO - 'title': 'talos-linux64-ix-004', 03:40:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:40:31 INFO - 'use_talos_json': True, 03:40:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:40:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:40:31 INFO - 'work_dir': 'build'} 03:40:31 INFO - ##### 03:40:31 INFO - ##### Running clobber step. 03:40:31 INFO - ##### 03:40:31 INFO - Running pre-action listener: _resource_record_pre_action 03:40:31 INFO - Running main action method: clobber 03:40:31 INFO - rmtree: /builds/slave/test/build 03:40:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:40:31 INFO - Running post-action listener: _resource_record_post_action 03:40:31 INFO - ##### 03:40:31 INFO - ##### Finished clobber step (success) 03:40:31 INFO - ##### 03:40:31 INFO - ##### 03:40:31 INFO - ##### Running read-buildbot-config step. 03:40:31 INFO - ##### 03:40:31 INFO - Running pre-action listener: _resource_record_pre_action 03:40:31 INFO - Running main action method: read_buildbot_config 03:40:31 INFO - Using buildbot properties: 03:40:31 INFO - { 03:40:31 INFO - "project": "", 03:40:31 INFO - "product": "firefox", 03:40:31 INFO - "script_repo_revision": "production", 03:40:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:40:31 INFO - "repository": "", 03:40:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:40:31 INFO - "buildid": "20160731234823", 03:40:31 INFO - "pgo_build": "True", 03:40:31 INFO - "basedir": "/builds/slave/test", 03:40:31 INFO - "buildnumber": 426, 03:40:31 INFO - "slavename": "talos-linux64-ix-004", 03:40:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:40:31 INFO - "platform": "ubuntu64_hw", 03:40:31 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:40:31 INFO - "branch": "mozilla-aurora", 03:40:31 INFO - "repo_path": "releases/mozilla-aurora", 03:40:31 INFO - "revision": "fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff", 03:40:31 INFO - "stage_platform": "linux64-pgo", 03:40:31 INFO - "builduid": "ac593188bfc9435eb9125393ed1fd078", 03:40:31 INFO - "slavebuilddir": "test" 03:40:31 INFO - } 03:40:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:40:31 INFO - Running post-action listener: _resource_record_post_action 03:40:31 INFO - ##### 03:40:31 INFO - ##### Finished read-buildbot-config step (success) 03:40:31 INFO - ##### 03:40:31 INFO - ##### 03:40:31 INFO - ##### Running download-and-extract step. 03:40:31 INFO - ##### 03:40:31 INFO - Running pre-action listener: _resource_record_pre_action 03:40:31 INFO - Running main action method: download_and_extract 03:40:31 INFO - mkdir: /builds/slave/test/build/tests 03:40: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')]} 03:40:31 INFO - https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:40:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:40:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:40:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:40:35 INFO - Downloaded 1361 bytes. 03:40:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:40:35 INFO - Using the following test package requirements: 03:40:35 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:35 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:40:35 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:40:35 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:35 INFO - u'jsshell-linux-x86_64.zip'], 03:40:35 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:40:35 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:35 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:40:35 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:40:35 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:40:35 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:40:35 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:35 INFO - https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:40:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:48 INFO - Downloaded 21967710 bytes. 03:40:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:40:49 INFO - Return code: 0 03:40:49 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:49 INFO - https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:40:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:40:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:54 INFO - Downloaded 21967710 bytes. 03:40:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:40:56 INFO - Return code: 0 03:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:56 INFO - https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:40:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:40:57 INFO - Downloaded 10833369 bytes. 03:40:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:40:57 INFO - Return code: 0 03:40: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')]} 03:40:57 INFO - https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:40:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:40:58 INFO - Downloaded 61985118 bytes. 03:40:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:58 INFO - mkdir: /builds/slave/test/properties 03:40:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:58 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:58 INFO - Contents: 03:40:58 INFO - build_url:https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:59 INFO - Running post-action listener: _resource_record_post_action 03:40:59 INFO - Running post-action listener: set_extra_try_arguments 03:40:59 INFO - ##### 03:40:59 INFO - ##### Finished download-and-extract step (success) 03:40:59 INFO - ##### 03:40:59 INFO - ##### 03:40:59 INFO - ##### Running populate-webroot step. 03:40:59 INFO - ##### 03:40:59 INFO - Running pre-action listener: _resource_record_pre_action 03:40:59 INFO - Running main action method: populate_webroot 03:40:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:59 INFO - '--tppagecycles', 03:40:59 INFO - '7'], 03:40:59 INFO - 'tests': ['tsvgm']}}, 03:40:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:40:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:40:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:40:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:40:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:59 INFO - 'talos_options': ['--disable-e10s'], 03:40:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:59 INFO - 'talos_options': ['--disable-e10s'], 03:40:59 INFO - 'tests': ['damp', 'tps']}, 03:40:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:59 INFO - 'tests': ['damp', 'tps']}, 03:40:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:40:59 INFO - 'tests': ['dromaeo_dom']}, 03:40:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:40:59 INFO - 'tests': ['a11yr', 03:40:59 INFO - 'ts_paint', 03:40:59 INFO - 'tpaint', 03:40:59 INFO - 'sessionrestore', 03:40:59 INFO - 'sessionrestore_no_auto_restore', 03:40:59 INFO - 'tabpaint']}, 03:40:59 INFO - 'other-e10s': {'tests': ['a11yr', 03:40:59 INFO - 'ts_paint', 03:40:59 INFO - 'tpaint', 03:40:59 INFO - 'sessionrestore', 03:40:59 INFO - 'sessionrestore_no_auto_restore', 03:40:59 INFO - 'tabpaint']}, 03:40:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:40:59 INFO - 'ts_paint', 03:40:59 INFO - 'tpaint', 03:40:59 INFO - 'sessionrestore', 03:40:59 INFO - 'sessionrestore_no_auto_restore', 03:40:59 INFO - 'tabpaint']}, 03:40:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:40:59 INFO - 'ts_paint', 03:40:59 INFO - 'tpaint', 03:40:59 INFO - 'sessionrestore', 03:40:59 INFO - 'sessionrestore_no_auto_restore', 03:40:59 INFO - 'tabpaint']}, 03:40:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:40:59 INFO - 'tests': ['a11yr', 03:40:59 INFO - 'ts_paint', 03:40:59 INFO - 'tpaint', 03:40:59 INFO - 'sessionrestore', 03:40:59 INFO - 'sessionrestore_no_auto_restore', 03:40:59 INFO - 'tabpaint']}, 03:40:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:40:59 INFO - 'tests': ['a11yr', 03:40:59 INFO - 'ts_paint', 03:40:59 INFO - 'tpaint', 03:40:59 INFO - 'sessionrestore', 03:40:59 INFO - 'sessionrestore_no_auto_restore', 03:40:59 INFO - 'tabpaint']}, 03:40:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:40:59 INFO - 'tests': ['tsvgx', 03:40:59 INFO - 'tsvgr_opacity', 03:40:59 INFO - 'tart', 03:40:59 INFO - 'tscrollx', 03:40:59 INFO - 'cart']}, 03:40:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:40:59 INFO - 'tsvgr_opacity', 03:40:59 INFO - 'tart', 03:40:59 INFO - 'tscrollx', 03:40:59 INFO - 'cart']}, 03:40:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:59 INFO - 'talos_options': ['--disable-e10s'], 03:40:59 INFO - 'tests': ['tp5o']}, 03:40:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:59 INFO - 'tests': ['tp5o']}, 03:40:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:59 INFO - 'talos_options': ['--disable-e10s', 03:40:59 INFO - '--xperf_path', 03:40:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:59 INFO - 'tests': ['tp5n']}, 03:40:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:59 INFO - 'talos_options': ['--xperf_path', 03:40:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:59 INFO - 'tests': ['tp5n']}}, 03:40:59 INFO - 'talos.zip': {'path': '', 03:40:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:59 INFO - Running post-action listener: _resource_record_post_action 03:40:59 INFO - ##### 03:40:59 INFO - ##### Finished populate-webroot step (success) 03:40:59 INFO - ##### 03:40:59 INFO - ##### 03:40:59 INFO - ##### Running create-virtualenv step. 03:40:59 INFO - ##### 03:40:59 INFO - Running pre-action listener: _resource_record_pre_action 03:40:59 INFO - Running main action method: create_virtualenv 03:40:59 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:40:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:59 INFO - Using real prefix '/usr' 03:40:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:41:00 INFO - Installing distribute.............................................................................................................................................................................................done. 03:41:02 INFO - Installing pip.................done. 03:41:02 INFO - Return code: 0 03:41:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8f5704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f71c0>, '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 0x10f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:41:02 INFO - Using env: {'DISPLAY': ':0', 03:41:02 INFO - 'HOME': '/home/cltbld', 03:41:02 INFO - 'LANG': 'en_US.UTF-8', 03:41:02 INFO - 'LANGUAGE': 'en_US:en', 03:41:02 INFO - 'LOGNAME': 'cltbld', 03:41:02 INFO - 'MAIL': '/var/mail/cltbld', 03:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:02 INFO - 'MOZ_NO_REMOTE': '1', 03:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:02 INFO - 'NO_EM_RESTART': '1', 03:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:02 INFO - 'PWD': '/builds/slave/test', 03:41:02 INFO - 'SHELL': '/bin/bash', 03:41:02 INFO - 'SHLVL': '1', 03:41:02 INFO - 'TERM': 'linux', 03:41:02 INFO - 'TMOUT': '86400', 03:41:02 INFO - 'USER': 'cltbld', 03:41:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 03:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:02 INFO - '_': '/tools/buildbot/bin/python'} 03:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:41:02 INFO - Cleaning up... 03:41:02 INFO - Return code: 0 03:41:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc8f5704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f71c0>, '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 0x10f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:41:02 INFO - Using env: {'DISPLAY': ':0', 03:41:02 INFO - 'HOME': '/home/cltbld', 03:41:02 INFO - 'LANG': 'en_US.UTF-8', 03:41:02 INFO - 'LANGUAGE': 'en_US:en', 03:41:02 INFO - 'LOGNAME': 'cltbld', 03:41:02 INFO - 'MAIL': '/var/mail/cltbld', 03:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:02 INFO - 'MOZ_NO_REMOTE': '1', 03:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:02 INFO - 'NO_EM_RESTART': '1', 03:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:02 INFO - 'PWD': '/builds/slave/test', 03:41:02 INFO - 'SHELL': '/bin/bash', 03:41:02 INFO - 'SHLVL': '1', 03:41:02 INFO - 'TERM': 'linux', 03:41:02 INFO - 'TMOUT': '86400', 03:41:02 INFO - 'USER': 'cltbld', 03:41:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 03:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:02 INFO - '_': '/tools/buildbot/bin/python'} 03:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:02 INFO - Downloading/unpacking psutil>=3.1.1 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:04 INFO - Installing collected packages: psutil 03:41:04 INFO - Running setup.py install for psutil 03:41:04 INFO - building 'psutil._psutil_linux' extension 03:41:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:41:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:41:04 INFO - building 'psutil._psutil_posix' extension 03:41:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:41:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:41:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:05 INFO - Successfully installed psutil 03:41:05 INFO - Cleaning up... 03:41:05 INFO - Return code: 0 03:41:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:05 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 0x7fc8f5704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f71c0>, '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 0x10f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:41:05 INFO - Using env: {'DISPLAY': ':0', 03:41:05 INFO - 'HOME': '/home/cltbld', 03:41:05 INFO - 'LANG': 'en_US.UTF-8', 03:41:05 INFO - 'LANGUAGE': 'en_US:en', 03:41:05 INFO - 'LOGNAME': 'cltbld', 03:41:05 INFO - 'MAIL': '/var/mail/cltbld', 03:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:05 INFO - 'MOZ_NO_REMOTE': '1', 03:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:05 INFO - 'NO_EM_RESTART': '1', 03:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:05 INFO - 'PWD': '/builds/slave/test', 03:41:05 INFO - 'SHELL': '/bin/bash', 03:41:05 INFO - 'SHLVL': '1', 03:41:05 INFO - 'TERM': 'linux', 03:41:05 INFO - 'TMOUT': '86400', 03:41:05 INFO - 'USER': 'cltbld', 03:41:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 03:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:05 INFO - '_': '/tools/buildbot/bin/python'} 03:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:41:08 INFO - Installing collected packages: mozsystemmonitor 03:41:08 INFO - Running setup.py install for mozsystemmonitor 03:41:08 INFO - Successfully installed mozsystemmonitor 03:41:08 INFO - Cleaning up... 03:41:08 INFO - Return code: 0 03:41:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:08 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 0x7fc8f5704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f71c0>, '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 0x10f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:41:08 INFO - Using env: {'DISPLAY': ':0', 03:41:08 INFO - 'HOME': '/home/cltbld', 03:41:08 INFO - 'LANG': 'en_US.UTF-8', 03:41:08 INFO - 'LANGUAGE': 'en_US:en', 03:41:08 INFO - 'LOGNAME': 'cltbld', 03:41:08 INFO - 'MAIL': '/var/mail/cltbld', 03:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:08 INFO - 'MOZ_NO_REMOTE': '1', 03:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:08 INFO - 'NO_EM_RESTART': '1', 03:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:08 INFO - 'PWD': '/builds/slave/test', 03:41:08 INFO - 'SHELL': '/bin/bash', 03:41:08 INFO - 'SHLVL': '1', 03:41:08 INFO - 'TERM': 'linux', 03:41:08 INFO - 'TMOUT': '86400', 03:41:08 INFO - 'USER': 'cltbld', 03:41:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 03:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:08 INFO - '_': '/tools/buildbot/bin/python'} 03:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:08 INFO - Downloading/unpacking jsonschema==2.5.1 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:10 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:10 INFO - warning: no files found matching '*.txt' 03:41:10 INFO - no previously-included directories found matching 'build' 03:41:10 INFO - no previously-included directories found matching 'dist' 03:41:10 INFO - no previously-included directories found matching '.git*' 03:41:10 INFO - Installing collected packages: jsonschema, functools32 03:41:10 INFO - Running setup.py install for functools32 03:41:10 INFO - warning: no files found matching '*.txt' 03:41:10 INFO - no previously-included directories found matching 'build' 03:41:10 INFO - no previously-included directories found matching 'dist' 03:41:10 INFO - no previously-included directories found matching '.git*' 03:41:10 INFO - Successfully installed jsonschema functools32 03:41:10 INFO - Cleaning up... 03:41:10 INFO - Return code: 0 03:41:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:10 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 0x7fc8f5704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f71c0>, '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 0x10f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:41:10 INFO - Using env: {'DISPLAY': ':0', 03:41:10 INFO - 'HOME': '/home/cltbld', 03:41:10 INFO - 'LANG': 'en_US.UTF-8', 03:41:10 INFO - 'LANGUAGE': 'en_US:en', 03:41:10 INFO - 'LOGNAME': 'cltbld', 03:41:10 INFO - 'MAIL': '/var/mail/cltbld', 03:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:10 INFO - 'MOZ_NO_REMOTE': '1', 03:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:10 INFO - 'NO_EM_RESTART': '1', 03:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:10 INFO - 'PWD': '/builds/slave/test', 03:41:10 INFO - 'SHELL': '/bin/bash', 03:41:10 INFO - 'SHLVL': '1', 03:41:10 INFO - 'TERM': 'linux', 03:41:10 INFO - 'TMOUT': '86400', 03:41:10 INFO - 'USER': 'cltbld', 03:41:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 03:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:10 INFO - '_': '/tools/buildbot/bin/python'} 03:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:11 INFO - Downloading/unpacking blobuploader==1.2.4 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41:13 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41:13 INFO - Downloading docopt-0.6.1.tar.gz 03:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:13 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:13 INFO - Running setup.py install for blobuploader 03:41:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:13 INFO - Running setup.py install for requests 03:41:14 INFO - Running setup.py install for docopt 03:41:14 INFO - Successfully installed blobuploader requests docopt 03:41:14 INFO - Cleaning up... 03:41:14 INFO - Return code: 0 03:41:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:14 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 0x7fc8f5704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f71c0>, '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 0x10f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:14 INFO - Using env: {'DISPLAY': ':0', 03:41:14 INFO - 'HOME': '/home/cltbld', 03:41:14 INFO - 'LANG': 'en_US.UTF-8', 03:41:14 INFO - 'LANGUAGE': 'en_US:en', 03:41:14 INFO - 'LOGNAME': 'cltbld', 03:41:14 INFO - 'MAIL': '/var/mail/cltbld', 03:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:14 INFO - 'MOZ_NO_REMOTE': '1', 03:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:14 INFO - 'NO_EM_RESTART': '1', 03:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:14 INFO - 'PWD': '/builds/slave/test', 03:41:14 INFO - 'SHELL': '/bin/bash', 03:41:14 INFO - 'SHLVL': '1', 03:41:14 INFO - 'TERM': 'linux', 03:41:14 INFO - 'TMOUT': '86400', 03:41:14 INFO - 'USER': 'cltbld', 03:41:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 03:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:14 INFO - '_': '/tools/buildbot/bin/python'} 03:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:14 INFO - Running setup.py (path:/tmp/pip-pu6_VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:14 INFO - Running setup.py (path:/tmp/pip-uj4BvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:14 INFO - Running setup.py (path:/tmp/pip-JM0x8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:14 INFO - Running setup.py (path:/tmp/pip-yMGQGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:14 INFO - Running setup.py (path:/tmp/pip-dELfj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:15 INFO - Running setup.py (path:/tmp/pip-ckFuHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:15 INFO - Running setup.py (path:/tmp/pip-jUcn2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:15 INFO - Running setup.py (path:/tmp/pip-K5T7pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:15 INFO - Running setup.py (path:/tmp/pip-akeqrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:15 INFO - Running setup.py (path:/tmp/pip-7DJa2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:15 INFO - Running setup.py (path:/tmp/pip-cP87MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:15 INFO - Running setup.py (path:/tmp/pip-TzvLsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:15 INFO - Running setup.py (path:/tmp/pip-_cXh8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:15 INFO - Running setup.py (path:/tmp/pip-r6pfbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:15 INFO - Running setup.py (path:/tmp/pip-H7M8ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:15 INFO - Running setup.py (path:/tmp/pip-9pFD90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:15 INFO - Running setup.py (path:/tmp/pip-HH8DQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:15 INFO - Running setup.py install for manifestparser 03:41:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:16 INFO - Running setup.py install for mozcrash 03:41:16 INFO - Running setup.py install for mozdebug 03:41:16 INFO - Running setup.py install for mozdevice 03:41:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:16 INFO - Running setup.py install for mozfile 03:41:16 INFO - Running setup.py install for mozhttpd 03:41:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:16 INFO - Running setup.py install for mozinfo 03:41:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:16 INFO - Running setup.py install for mozInstall 03:41:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:16 INFO - Running setup.py install for mozleak 03:41:16 INFO - Running setup.py install for mozlog 03:41:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:16 INFO - Running setup.py install for moznetwork 03:41:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:17 INFO - Running setup.py install for mozprocess 03:41:17 INFO - Running setup.py install for mozprofile 03:41:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:17 INFO - Running setup.py install for mozrunner 03:41:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:17 INFO - Running setup.py install for mozscreenshot 03:41:17 INFO - Running setup.py install for moztest 03:41:17 INFO - Running setup.py install for mozversion 03:41:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:17 INFO - Cleaning up... 03:41:17 INFO - Return code: 0 03:41:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:17 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 0x7fc8f5704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f71c0>, '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 0x10f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:17 INFO - Using env: {'DISPLAY': ':0', 03:41:17 INFO - 'HOME': '/home/cltbld', 03:41:17 INFO - 'LANG': 'en_US.UTF-8', 03:41:17 INFO - 'LANGUAGE': 'en_US:en', 03:41:17 INFO - 'LOGNAME': 'cltbld', 03:41:17 INFO - 'MAIL': '/var/mail/cltbld', 03:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:17 INFO - 'MOZ_NO_REMOTE': '1', 03:41:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:17 INFO - 'NO_EM_RESTART': '1', 03:41:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:17 INFO - 'PWD': '/builds/slave/test', 03:41:17 INFO - 'SHELL': '/bin/bash', 03:41:17 INFO - 'SHLVL': '1', 03:41:17 INFO - 'TERM': 'linux', 03:41:17 INFO - 'TMOUT': '86400', 03:41:17 INFO - 'USER': 'cltbld', 03:41:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 03:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:17 INFO - '_': '/tools/buildbot/bin/python'} 03:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:17 INFO - Running setup.py (path:/tmp/pip-RuayXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:17 INFO - Running setup.py (path:/tmp/pip-Z0vgkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:18 INFO - Running setup.py (path:/tmp/pip-J8ck7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:18 INFO - Running setup.py (path:/tmp/pip-cgbIP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:18 INFO - Running setup.py (path:/tmp/pip-GXDDGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:18 INFO - Running setup.py (path:/tmp/pip-s_dyn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:18 INFO - Running setup.py (path:/tmp/pip-Vbn4oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:18 INFO - Running setup.py (path:/tmp/pip-siKega-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:18 INFO - Running setup.py (path:/tmp/pip-wnsUGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:18 INFO - Running setup.py (path:/tmp/pip-J6S3Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:18 INFO - Running setup.py (path:/tmp/pip-iblzoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:18 INFO - Running setup.py (path:/tmp/pip-4CZCtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:18 INFO - Running setup.py (path:/tmp/pip-AitdzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:18 INFO - Running setup.py (path:/tmp/pip-Y2048u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:18 INFO - Running setup.py (path:/tmp/pip-CWNTi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:19 INFO - Running setup.py (path:/tmp/pip-kDVxit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:19 INFO - Running setup.py (path:/tmp/pip-ncWIHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:21 INFO - Downloading blessings-1.6.tar.gz 03:41:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:41:21 INFO - Installing collected packages: blessings 03:41:21 INFO - Running setup.py install for blessings 03:41:21 INFO - Successfully installed blessings 03:41:21 INFO - Cleaning up... 03:41:21 INFO - Return code: 0 03:41:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:41:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:21 INFO - Reading from file tmpfile_stdout 03:41:21 INFO - Current package versions: 03:41:21 INFO - argparse == 1.2.1 03:41:21 INFO - blessings == 1.6 03:41:21 INFO - blobuploader == 1.2.4 03:41:21 INFO - docopt == 0.6.1 03:41:21 INFO - functools32 == 3.2.3-2 03:41:21 INFO - jsonschema == 2.5.1 03:41:21 INFO - manifestparser == 1.1 03:41:21 INFO - mozInstall == 1.12 03:41:21 INFO - mozcrash == 0.17 03:41:21 INFO - mozdebug == 0.1 03:41:21 INFO - mozdevice == 0.48 03:41:21 INFO - mozfile == 1.2 03:41:21 INFO - mozhttpd == 0.7 03:41:21 INFO - mozinfo == 0.9 03:41:21 INFO - mozleak == 0.1 03:41:21 INFO - mozlog == 3.2 03:41:21 INFO - moznetwork == 0.27 03:41:21 INFO - mozprocess == 0.23 03:41:21 INFO - mozprofile == 0.28 03:41:21 INFO - mozrunner == 6.12 03:41:21 INFO - mozscreenshot == 0.1 03:41:21 INFO - mozsystemmonitor == 0.3 03:41:21 INFO - moztest == 0.7 03:41:21 INFO - mozversion == 1.4 03:41:21 INFO - psutil == 3.1.1 03:41:21 INFO - requests == 1.2.3 03:41:21 INFO - wsgiref == 0.1.2 03:41:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:21 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 0x7fc8f5704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f71c0>, '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 0x10f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:21 INFO - Using env: {'DISPLAY': ':0', 03:41:21 INFO - 'HOME': '/home/cltbld', 03:41:21 INFO - 'LANG': 'en_US.UTF-8', 03:41:21 INFO - 'LANGUAGE': 'en_US:en', 03:41:21 INFO - 'LOGNAME': 'cltbld', 03:41:21 INFO - 'MAIL': '/var/mail/cltbld', 03:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:21 INFO - 'MOZ_NO_REMOTE': '1', 03:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:21 INFO - 'NO_EM_RESTART': '1', 03:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:21 INFO - 'PWD': '/builds/slave/test', 03:41:21 INFO - 'SHELL': '/bin/bash', 03:41:21 INFO - 'SHLVL': '1', 03:41:21 INFO - 'TERM': 'linux', 03:41:21 INFO - 'TMOUT': '86400', 03:41:21 INFO - 'USER': 'cltbld', 03:41:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 03:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:21 INFO - '_': '/tools/buildbot/bin/python'} 03:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:21 INFO - Cleaning up... 03:41:21 INFO - Return code: 0 03:41:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:21 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 0x7fc8f5704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f71c0>, '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 0x10f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:41:21 INFO - Using env: {'DISPLAY': ':0', 03:41:21 INFO - 'HOME': '/home/cltbld', 03:41:21 INFO - 'LANG': 'en_US.UTF-8', 03:41:21 INFO - 'LANGUAGE': 'en_US:en', 03:41:21 INFO - 'LOGNAME': 'cltbld', 03:41:21 INFO - 'MAIL': '/var/mail/cltbld', 03:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:21 INFO - 'MOZ_NO_REMOTE': '1', 03:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:21 INFO - 'NO_EM_RESTART': '1', 03:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:21 INFO - 'PWD': '/builds/slave/test', 03:41:21 INFO - 'SHELL': '/bin/bash', 03:41:21 INFO - 'SHLVL': '1', 03:41:21 INFO - 'TERM': 'linux', 03:41:21 INFO - 'TMOUT': '86400', 03:41:21 INFO - 'USER': 'cltbld', 03:41:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 03:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:21 INFO - '_': '/tools/buildbot/bin/python'} 03:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:41:21 INFO - Cleaning up... 03:41:21 INFO - Return code: 0 03:41:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:21 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 0x7fc8f5704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f71c0>, '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 0x10f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:41:21 INFO - Using env: {'DISPLAY': ':0', 03:41:21 INFO - 'HOME': '/home/cltbld', 03:41:21 INFO - 'LANG': 'en_US.UTF-8', 03:41:21 INFO - 'LANGUAGE': 'en_US:en', 03:41:21 INFO - 'LOGNAME': 'cltbld', 03:41:21 INFO - 'MAIL': '/var/mail/cltbld', 03:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:21 INFO - 'MOZ_NO_REMOTE': '1', 03:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:21 INFO - 'NO_EM_RESTART': '1', 03:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:21 INFO - 'PWD': '/builds/slave/test', 03:41:21 INFO - 'SHELL': '/bin/bash', 03:41:21 INFO - 'SHLVL': '1', 03:41:21 INFO - 'TERM': 'linux', 03:41:21 INFO - 'TMOUT': '86400', 03:41:21 INFO - 'USER': 'cltbld', 03:41:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 03:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:21 INFO - '_': '/tools/buildbot/bin/python'} 03:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:22 INFO - Downloading/unpacking flake8 03:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:41:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:41:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:41:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:41:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:41:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:41:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:41:24 INFO - no previously-included directories found matching 'docs/_build' 03:41:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:41:24 INFO - Running setup.py install for pep8 03:41:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:41:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:41:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:41:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:41:24 INFO - no previously-included directories found matching 'docs/_build' 03:41:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:41:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:41:24 INFO - Cleaning up... 03:41:25 INFO - Return code: 0 03:41:25 INFO - Running post-action listener: _resource_record_post_action 03:41:25 INFO - Running post-action listener: _start_resource_monitoring 03:41:25 INFO - Starting resource monitoring. 03:41:25 INFO - ##### 03:41:25 INFO - ##### Finished create-virtualenv step (success) 03:41:25 INFO - ##### 03:41:25 INFO - ##### 03:41:25 INFO - ##### Running install step. 03:41:25 INFO - ##### 03:41:25 INFO - Running pre-action listener: _resource_record_pre_action 03:41:25 INFO - Running main action method: install 03:41:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:25 INFO - Reading from file tmpfile_stdout 03:41:25 INFO - Detecting whether we're running mozinstall >=1.0... 03:41:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:41:25 INFO - Reading from file tmpfile_stdout 03:41:25 INFO - Output received: 03:41:25 INFO - Usage: mozinstall [options] installer 03:41:25 INFO - Options: 03:41:25 INFO - -h, --help show this help message and exit 03:41:25 INFO - -d DEST, --destination=DEST 03:41:25 INFO - Directory to install application into. [default: 03:41:25 INFO - "/builds/slave/test"] 03:41:25 INFO - --app=APP Application being installed. [default: firefox] 03:41:25 INFO - mkdir: /builds/slave/test/build/application 03:41:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:41:40 INFO - Reading from file tmpfile_stdout 03:41:40 INFO - Output received: 03:41:40 INFO - /builds/slave/test/build/application/firefox/firefox 03:41:40 INFO - Running post-action listener: _resource_record_post_action 03:41:40 INFO - ##### 03:41:40 INFO - ##### Finished install step (success) 03:41:40 INFO - ##### 03:41:40 INFO - ##### 03:41:40 INFO - ##### Running run-tests step. 03:41:40 INFO - ##### 03:41:40 INFO - Running pre-action listener: _resource_record_pre_action 03:41:40 INFO - Running main action method: run_tests 03:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:40 INFO - Python 2.7.3 03:41:40 INFO - Return code: 0 03:41:40 INFO - grabbing minidump binary from tooltool 03:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:40 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 0x10f71c0>, '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 0x10f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:41:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:41:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:41:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:41 INFO - Return code: 0 03:41:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:41:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:41:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:41:41 INFO - Return code: 0 03:41:41 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/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 03:41:41 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/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 03:41:41 INFO - Using env: {'DISPLAY': ':0', 03:41:41 INFO - 'HOME': '/home/cltbld', 03:41:41 INFO - 'LANG': 'en_US.UTF-8', 03:41:41 INFO - 'LANGUAGE': 'en_US:en', 03:41:41 INFO - 'LOGNAME': 'cltbld', 03:41:41 INFO - 'MAIL': '/var/mail/cltbld', 03:41:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:41 INFO - 'MOZ_NO_REMOTE': '1', 03:41:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:41 INFO - 'NO_EM_RESTART': '1', 03:41:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:41 INFO - 'PWD': '/builds/slave/test', 03:41:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:41 INFO - 'SHELL': '/bin/bash', 03:41:41 INFO - 'SHLVL': '1', 03:41:41 INFO - 'TERM': 'linux', 03:41:41 INFO - 'TMOUT': '86400', 03:41:41 INFO - 'USER': 'cltbld', 03:41:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672', 03:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:41 INFO - '_': '/tools/buildbot/bin/python'} 03:41:41 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/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 03:41:42 INFO - mozversion application_buildid: 20160731234823 03:41:42 INFO - mozversion application_changeset: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff 03:41:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:41:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:42 INFO - mozversion application_name: Firefox 03:41:42 INFO - mozversion application_remotingname: firefox-dev 03:41:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:42 INFO - mozversion application_vendor: Mozilla 03:41:42 INFO - mozversion application_version: 49.0a2 03:41:42 INFO - mozversion platform_buildid: 20160731234823 03:41:42 INFO - mozversion platform_changeset: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff 03:41:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:42 INFO - mozversion platform_version: 49.0a2 03:41:42 INFO - using testdate: 1470048102 03:41:42 INFO - actual date: 1470048102 03:41:42 INFO - starting webserver on 'localhost:48471' 03:41:42 INFO - SUITE-START | Running 2 tests 03:41:42 INFO - TEST-START | dromaeo_css 03:41:42 INFO - operating with platform_type : linux_ 03:41:42 INFO - Initialising browser for dromaeo_css test... 03:41:42 INFO - TEST-INFO | started process 9271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnp_jsc/profile http://localhost:48471/getInfo.html) 03:41:46 INFO - PROCESS | 9271 | __metrics Screen width/height:1600/1200 03:41:46 INFO - PROCESS | 9271 | colorDepth:24 03:41:46 INFO - PROCESS | 9271 | Browser inner width/height: 1024/697 03:41:46 INFO - PROCESS | 9271 | __metrics 03:41:47 ERROR - PROCESS | 9271 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 03:41:48 INFO - TEST-INFO | 9271: exit 0 03:41:48 INFO - Browser initialized. 03:41:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:48 INFO - TEST-INFO | started process 9401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnp_jsc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:59 INFO - PROCESS | 9401 | RSS: Main: 153923584 03:41:59 INFO - PROCESS | 9401 | 03:42:49 INFO - PROCESS | 9401 | 1470048169523 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:44:57 INFO - PROCESS | 9401 | Cycle 1(1): loaded http://localhost:48471/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48471/tests/dromaeo/cssquery-ext.html) 03:44:58 INFO - PROCESS | 9401 | RSS: Main: 158048256 03:44:58 INFO - PROCESS | 9401 | 03:48:00 INFO - PROCESS | 9401 | Cycle 1(1): loaded http://localhost:48471/tests/dromaeo/cssquery-ext.html (next: http://localhost:48471/tests/dromaeo/cssquery-jquery.html) 03:48:01 INFO - PROCESS | 9401 | RSS: Main: 155947008 03:48:01 INFO - PROCESS | 9401 | 03:51:02 INFO - PROCESS | 9401 | Cycle 1(1): loaded http://localhost:48471/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48471/tests/dromaeo/cssquery-mootools.html) 03:51:03 INFO - PROCESS | 9401 | RSS: Main: 154959872 03:51:03 INFO - PROCESS | 9401 | 03:54:05 INFO - PROCESS | 9401 | Cycle 1(1): loaded http://localhost:48471/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48471/tests/dromaeo/cssquery-prototype.html) 03:54:05 INFO - PROCESS | 9401 | RSS: Main: 154857472 03:54:05 INFO - PROCESS | 9401 | 03:57:08 INFO - PROCESS | 9401 | Cycle 1(1): loaded http://localhost:48471/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48471/tests/dromaeo/cssquery-yui.html) 03:57:08 INFO - PROCESS | 9401 | RSS: Main: 156864512 03:57:08 INFO - PROCESS | 9401 | 04:00:11 INFO - PROCESS | 9401 | Cycle 1(1): loaded http://localhost:48471/tests/dromaeo/cssquery-yui.html (next: http://localhost:48471/tests/dromaeo/cssquery-dojo.html) 04:00:11 INFO - PROCESS | 9401 | RSS: Main: 157241344 04:00:11 INFO - PROCESS | 9401 | 04:00:11 INFO - PROCESS | 9401 | __start_tp_report 04:00:11 INFO - PROCESS | 9401 | _x_x_mozilla_page_load 04:00:11 INFO - PROCESS | 9401 | _x_x_mozilla_page_load_details 04:00:11 INFO - PROCESS | 9401 | |i|pagename|runs| 04:00:11 INFO - PROCESS | 9401 | |0;dojo.html;3370.8820191293307;3385.8645654173833;3400.251944572193;3437.157896315403;3441.0365097772615;5646.7176641167935;5658.688772117532;5673.659580425172;5732.312122545301;5741.971290143543;5696.3733989261145;5733.197352370671;5734.340550836655;5743.913841292384;5749.971250143743;5081.1108056090125;5124.795008199686;5171.22431635254;5202.141646628321;5211.322528071364;5142.485751424865;5158.0199762045095;5212.374515058179;5217.295665085222;5228.189630607262;5170.224466330062;5182.067227898977;5223.582113430916;5224.582033437316;5255.237990491377;5190.11767999441;5207.765650545734;5259.684418934876;5265.947340526584;5276.419593844674;5155.71643559604;5194.68831870089;5272.209168624699;5280;5284.81503147388;5426.810061647863;5443.782248710047;5471.917921231185;5482.122860342366;5506.889862202774;6032.065029920369;6035.245594300713;6055.424734650202;6057;6058.909116363258;5972.25346831646;6106.755729770804;6122.173506576644;6125.693715314261;6157.78447754331;5631.380548139701;5704.201411802351;5705.62913410627;5736.2256095427;5761.135829625548;6264.906026409608;6274.968625156845;6302.65335406557;6310.558260921692;6332.968335158294;5902.409759024149;5918.082697181943;6048.848778780478;6057.939420605826;6062.545309101835;5985.850353741192;6111.708054759659;6126.533375816431;6138.754449821957;6147.754089836446;6054.485368743706;6069.241344831896;6074.058520929263;6126;6131.754729810757;5901.439363260483;5980.641161530322;6023.69881505923;6070.787522436782;6128.9693551531955;4585.12882552314;4638;4643.489216186217;4647.419072615923;4667.8599642010795;4159.667226621863;4168.458100446983;4179.686523510749;4180.331147016524;4205.558416366238;5916.467517923407;5925.911111333334;5949.0481522956115;5977.521798256129;5988.520918326523;6027.7287522061615;6066.423689749467;6111.348653136725;6130.6467468051915;6213.565050446426;5958.255218097738;5961.344252132262;5962.642241465526;5967.791127310524;5989.610675306091;5078.13671675816;5149.948500515022;5204.34945631796;5232.633715639869;5245.423003469616;6485.77299794505;6498.6425746583445;6512.5766825156215;6521.47828173745;6525.543211975211;6140.109684095871;6222;6232.376762323732;6234.2830574484515;6250.781222657185;6459.354064593503;6502.479801615765;6545.116409284686;6553.803385898431;6571.737130514726;6118.938810612015;6148.4773794227995;6156.199694039925;6164.907526387018;6175.135481032569;6074.301455332693;6118.143459915526;6132.110769107885;6220.440160385587;6280.654563998841;6099.451049405575;6105.053716673922;6115.879294474783;6122.123558664931;6138.386161383826;6042.8791424170395;6059.909101363572;6068.059450785136;6070.028795392716;6072.666003369857;5800.970995144998;5801.970990145022;5834.533237340917;5876.911846322223;5943.554233432424;5972.223610930551;6006.849828754316;6007.519398448201;6052;6066.4540191382985;5863.941360586339;5915.378885217162;5921.85195370102;5924.792632258022;5938.495227905676 04:00:11 INFO - PROCESS | 9401 | |1;ext.html;595.856994321363;649.172305310729;652.7943697735213;671.3253180553542;682.9925859357452;43764;48276.999999999956;48327;48333;48386.75806620962;48102.51897481024;48308.27537586939;48693;48702;48747.75626121873;9001.054889236633;9150.313726470507;9173.036831132735;9196.172344488994;9196.816063678722;9022.413543119708;9028.187463128317;9070;9123.133302336268;9127.224185944202;9090.727278181632;9132.863007054899;9151.222146117554;9194.08059194082;9208.217301529377;9125.72622821313;9131.041240669734;9137.862932056025;9157.496337701425;9180.6786762463;8980.506072166028;9086.45481271126;9089.27285817133;9125.224355929753;9137.04061073591;43907;44454.77772611116;44537.55462445367;44607.77696111531;44660.3300950486;3674.8713795017316;3747.2318174774377;4336.111097225062;4404;4481.6638752093395;35894.282114357564;36022.45966310507;36069.63930360689;36127.096822579384;36177.457338139946;4635.629149668019;4830.855074347775;4841.467438581753;4852.8544143675745;4868.659193856396;282145;282808;283001;283635;285436.57281713665;67202.66398667975;67932;68025.31974680288;68062.31937680658;68093.65953170203;40317.79841100776;41006;41102;43134.352984705256;71676.28323716696;18489.630207396047;18509.7223541647;18599.44201673952;18605.255789768256;18678.159482823306;13128.146670466389;13142.145760525535;13186.274754888573;13220.801687974688;13238.470461181445;21701.891490542446;21720.674189887166;21965.121395144015;21988.560228795333;22035.449113771963;7704.614769261514;7861.278606791226;7878.322904627162;7991.72028978983;8052.114267430578;971.489967766928;1042.8748550174028;1072.4905669806778;1104.13877175803;1152.677250369881;34777.30445391078;34845.30309393798;35269.47095793565;35546.28907421837;35628.82185589056;1131.5191043806515;1156.6240971684235;1220.859601145862;1239.4794186441716;1316.782730849399;16965.575860603338;17246.310147593955;17266.65466690684;17447;17601.823981760273;607919;620118;633784;642220;650383;57336.71331643315;63306.36693633005;63493.68253158797;63719.36280637227;63788;1464.1068947941747;1500.3998400639614;1515.5301856424323;1520.9543713688606;1530.9770353444708;32889.506657400634;32892.671073289916;33512.49731253985;33674;33763;55734;55953;56006.1599076006;56276.43723562712;56400.43599564116;425770;428430;429431;429902;432877;30991;31246;31536.526952096196;31624.36751265008;31824.408779561392;50644.49355506398;50877;52036.21945670894;52393.7380313096;53574.46425535851;44296;45810.54189458063;46505.76747116243;46558;47207.055858883316;45446;46110.538894610625;46310.768446157555;47324.52675473201;47824.760876195396;46054.53945460502;46054.76972615116;46867.29699054585;46954.76522617365;47379.526204737514;38988.2202355957;39920.2015959685;39978.60021399865;40274.395884061174;40830.59169408268;30827.691723082484;31156.37687246288;31316.217094572818;31561.21096972594;31694.36611267808 04:00:11 INFO - PROCESS | 9401 | |2;jquery.html;430.80183115766744;433.71808324589017;434.4260694691217;434.85432380152645;439.9802008909601;19061.71407428888;19700.802991970093;19890.602187956232;21397.251096211636;21503.24738634144;17512.474625761246;18570.907145464287;19581.412557623295;19595.41213763586;20348.491287717778;5275.894482110355;5461.208124821898;5492.945070549284;5497.092979658351;5505.256790333294;5365.463453654643;5380.542653874406;5447.673139611636;5452.291202143736;5484.8354549363585;5351.625386222966;5381.704006279653;5446.863828404302;5460.399356070829;5463.453654634544;5394.811181608645;5406.59450541207;5443.2107344435235;5443.455654434564;5447.4824891635235;5135.204043373283;5240.842774716764;5283.128283833163;5293.04725149473;5307.2569840222395;15162.31769570361;18871.528211794677;20129.698054529195;23245.418864528354;24006.639900401507;2325.848819826706;2947.3810499795068;3051.771117166199;3082.6917308269217;3113.7820352575327;10084.848727269096;10361.533730982124;10693.572257109707;10935.507902144423;10998.34009959405;2004.5489764802949;2017.0923084611984;2140.154638917634;2143.689165071056;2194.5391467791783;87145.56427217886;89135.55432222862;90452.54773726156;94124;94242.99999999932;9820.65627703027;10377.84433233502;10421.68734937953;10446.164306855586;11935.761284774257;14440.061396009225;14594.34325455357;14621.853781462049;14661.780073298909;14708.705825883637;8219.876701849476;8263.421560490708;8291.626876790559;8320.83358332842;8372.455790373606;8002.679892804339;8037.879431808527;8112.594370281462;8159.79600509992;8197.385196110316;4356.803943822472;4471.5081341052455;4473.329000649928;4477.7313361197785;4536.705114167568;2152.5910077085305;2159.978400216009;2163.556470923457;2164.177612507237;2175.7171567696414;966.8308046092046;1006.7332156978407;1016.4714348538719;1042.5152304178594;1079.4926384599225;19886.801131988785;20001.799982000284;20251.79748202499;20461.386158415273;20637.17451301961;1027.3476342522404;1049.5172220778375;1049.9265051446325;1065.9200559957878;1081.8972197641212;11179.049780768562;11368.147388945863;11450.141239407078;11540.845915408392;11585.478653460614;578297;580942;583381;598285;598529;61082.694586526784;81772;86624.56687716646;89759.55120224488;91827.54086229659;1067.4182570499097;1095.8630171228597;1107.9335239885634;1117.698221480212;1118.6532175025604;18137.455876323733;18560.535986600444;18639.534011649273;18697;18884.3390481338;42552.5744742561;44351.11297774091;44609.55390446054;45692.54307456883;46265.3060204104;63952.68023660038;65025;66001.66999164973;66287.66856165689;66508;9042.864357034518;9203.217726493323;9273.907260927574;9390.060993900555;9490;13897;13920.930395348363;14040.368183431974;14125.929370353082;14140.78788818189;11718.648440546796;12327.815082773945;12425.875741242471;12472.690367511643;12570.497180112692;11434.714132146762;11580.131490138105;11819.586314478953;12038.157328986887;12380.133390662568;12333.444994975427;12571.1200215984;12812.654671259383;12818.493560349252;12922.353882305659;9179.678711245075;9186.127317904788;9220.216281616138;9318.767030824283;9392.530373481162;11946.283223006647;12074.818877717016;12182.75634487323;12200.389980501117;12225.877741222474 04:00:11 INFO - PROCESS | 9401 | |3;mootools.html;1573.1819453883984;1605.6226786705122;1825.543614096476;1911.2259534888376;1926.162119478028;8532.317414606832;9395.34232603718;9460.85808712869;10110.797784044324;10136.746581335461;9457.668981585646;9760.755981100476;9824.361416507922;9828;9849.65526206583;2501.0496011515597;2530.051230788454;2530.544501989641;2531.3798119460757;2538.923832285025;2437.2810021043747;2452.1049816816912;2470.1601455505124;2473.3445636906235;2482.156066937241;2462.8029757619347;2464.3346296499935;2523.470071285032;2530.202986059395;2534.1130604288537;2460.5324988252264;2474.480359124586;2477.913273035444;2493.9376515587073;2494.3888747256856;2394.473215892518;2408.2654790288957;2424.5635785558593;2429.6112621980396;2454.754524547549;9682.419054856731;9763;9792;9818.950905245429;9835.114839664464;5711.742971566248;5854.560907931879;5888.735006924699;5933.792317268918;5942.108683697436;3672.59601443841;3788.6969042476812;3850.7111966602615;3854.3062248795204;3863.97604634772;1212.799888018476;1215.9878401215963;1275.101053757099;1311.8753718396738;1344.8184495093233;13218.60344189676;13697.589072327746;13731.862681373259;14133.575992720234;14361.569152925429;4938.259261110862;5002.299678045077;5101.5408613224245;5101.770420331094;5112.309838171874;10884.891151088546;10898.945505272422;10953.17851161166;10954.068904143238;10956.835647465294;5908.556858235564;5909.2908850938165;5915.852103697442;5925.081612350093;5937.2578427696535;4666;5284.101702710548;5345.3852806926925;5367.704776237267;5430.484104010113;4100.138970816102;4111.030750430255;4136.875893723193;4159.313713237282;4164.271252530795;1241.3420886929941;1280.775864223757;1287.9162854414433;1294.4692676002794;1299.9870001300055;952.9047095290554;1094.1137678480457;1095.1731442760824;1098.1379617000775;1110.666799960025;6431;6576.276609572943;6588.802335929834;6634.0712300278;6695.598264104169;499;506.4150905703918;507.6776247083055;508.7456271864068;523.1995047577213;4493.955060449353;4585.174668559691;4588.701734387254;4609.101225261109;4611.654125940568;12184.939075304566;12478.875211247952;12592.055595830167;12659.303738294482;12690.746185076247;11616.767664646659;12167.33079680626;12221.75556488883;12431.191972521758;12451.190672606252;9165.541722913827;9175.908240917506;9239.445633262027;9304.441733495876;9394.06059394055;6461.773837915651;6689.933100668931;6886.552374095868;6929.376356127771;6933.757318493828;11258.437078145897;11412.600558980395;11527.827082593936;11833.112516561465;11876.049916006526;11693.473793679135;11835.940820295844;11862.169648124549;11894.405279736151;11970.162088654059;7831.921680783119;8540.615672294885;8755.91244087551;8838.867416988622;8975.775605609912;9867;9915.752106197402;9919.256055795988;9962.352447090916;9975.20198384113;7885.132635409986;8374.371922105745;8458.111898250841;8625.266852317372;8981.14679105484;8497.107803680525;8569.700060497853;8580.871286930826;8649;8691.608877600396;7783.532988020737;7816.140224575179;7850.646720897687;7887.921120788948;7903.695890178056;5501.092319767194;5584.609077364546;5620.606557540933;5667.716614169358;5753.827385178452;5421.132618780976;5461.726913654381;5604.943950560605;5744;5856.882862342814 04:00:11 INFO - PROCESS | 9401 | |4;prototype.html;352.03191224133633;352.5733862026948;356.80910712768656;358.8026585378041;359.1219468399762;5684.436779885534;5687.2606561147095;5697.116946873236;5766.567507436948;5801.738921748521;5626.859328516789;5660.915086273699;5666.376698563155;5670.262865827447;5677.318721753385;4284.550122237167;4366.67249956253;4371.737695738266;4375.6499480041675;4389.7146685465505;4351.238533256684;4367.475902891658;4420.845270415536;4431.02517446163;4441.844535441261;4389.648828093761;4409.911801763963;4411.4706235251815;4418.911621767563;4422.049259409227;4194.182134483777;4404.4494438195225;4406.713563618387;4408.316710909814;4429.623482004034;3889.572147063821;3892.1437283797804;3892.727509074366;3901.239258344624;3903.5315762108444;5363.839084827461;5369.328833895763;5439.945600543983;5456.181572764078;5460.6177567570285;4944.703317800908;4997.350344455234;5045.772940217699;5053.545180933734;5055.191169412877;5865;5880.852978675524;5895.35151133375;5897.734601942923;5897.764089436418;4248.681348898845;4258.189594867404;4260.424842646234;4264.530901600821;4266.445362102938;5967.19442875215;5988.131720900445;6109.725062372204;6162.815115546541;6197.597156184878;4335.913281734348;4338.609525142752;4343.262694921993;4343.609075183249;4356.041670832412;4373.169097871394;4381.474223093249;4401.273789824707;4402.603765661106;4407.2507673695545;4880.682755620874;5029.471905449948;5070.2141168119;5090.007448547498;5095.261187127846;5933.792317268875;5945.613535120204;5962.509372656836;5972.492338151219;5982.670953097621;1499.71505413971;1507.3970411835353;1508.4871143811156;1509.562226954171;1514.719776841288;908.418612088264;926.5459924637014;944.3814301632442;949.5869296855751;950.1923365139576;5126.205827960184;5129.692218466904;5130.204818253177;5153.252778347119;5195.454477279907;5411.836455162081;5437.401885792559;5453.64551304164;5470.890582188414;5486;4981.430849282465;5139.280500729901;5159.39450577456;5168.948310516922;5172.405173405032;2898.0581311073984;2916.4750344938116;2918.6059881916094;2920.53271476567;2936.6182396288345;5586.888262234733;5641.802536911188;5652.7173641318595;5678.854436261552;5702.344230413472;5309.256704061435;5443.346798384219;5521.585881058937;5561.220409468931;5581.49766521015;5612.242347283064;5631.183478395692;5651.463111004448;5654.575906807006;5738.713064346766;5100.311457953278;5335.478584134453;5363.892722145613;5423.511883930465;5425.240466334795;5312.096943519534;5324.307839980777;5356.250124982584;5360.42699504248;5762.740676669644;6297.433231009231;6414.486841052798;6426.903596445964;6443.613383197023;6478.611283323015;4178.597306548686;4183.937240941327;4203.705740598129;4205.474315710536;4216.3464662977285;5866.5893387462465;6137.84655383619;6167.660778657217;6205.2553693557065;6208.937910620836;6013.278406591237;6039.795474651808;6061.212042434456;6071.392860713893;6087.052143314097;5677.063284558167;6022.608530445507;6026.578139530191;6045.370263935202;6048.213732214784;5945.286565612154;5954.612950158225;5969.403059693996;5972.8805423892145;5994.370591088047;6057.969710151421;6066.9696651518225;6077.088436734349;6088.6042407243385;6088.817335479943;5525.696086715269;5866.208061911588;5876.764929402947;5890.204822348928;5947.345791962967 04:00:11 INFO - PROCESS | 9401 | |5;yui.html;764.4266799900075;784.697891311845;812.3257696112225;820.052838970988;839.0476808821988;16153.515394538168;16348.591285217875;16555;16582;16610.75083873743;15296.69406611867;15545.30046147926;15548.84451155488;15556.533304000897;15618.375264989387;708.606723268587;842.877782721505;859.5143743784773;864.2610567964363;866.1857853617611;854.3805740837905;854.799122206281;859.1108203009886;861.3195575495382;863.3352318714586;912.8950170730351;915.7985243246509;917.5504003038529;917.5824999625155;919.429953428875;904.0552622509427;905.1988989744091;905.9094090590921;907.0294784580534;908.9409188402733;664.5281849886586;667.2593421302399;668.7425341243608;669.5079116849112;669.9263081061129;15801.683966320725;15801.683966320725;15859.841401585953;15894.682106357925;15960.76058859118;14061.437542498288;15592.666005946481;16169.110698911556;16529.256183471774;16561.42035028768;12176;12524.686882827911;13687.863121368759;13688;13963.092398994033;4000.739951903117;4033.415154802537;4036.4752582164133;4070.7557546547005;4209.074003719177;82389.58805205996;82672.17327826704;82776.58611706903;83702;85936.14063859344;11811.271533306339;12009;12109.878901211052;12265.754684906253;12295.077869159848;18987.24051037943;20090.196392144444;20202.393928182177;20650.89674551648;21020.579588408145;8694.608742606599;8779.429337093068;8837.248833849066;9102.226310763659;9167.495787731605;4757.666963312604;4764.666473346832;4777.0684716479955;4778.641601879873;4947.356843610308;3765.8305376258136;3869.8258578364043;3873.709471789627;3884.4755957945317;3885.902852428712;619.8574327904518;671.2314400011959;675.7499725101645;675.8411773233287;677.1028387386634;641.3298103481873;677.2178134254943;725.8584576007628;730.7807657702668;742.354151887861;9984.400935943866;10116.797664046826;10334.379937203792;10469.371837689763;10490.423026733602;689.4794430205263;704.475166001322;707.8761216787042;708.6563016936782;725.7750097469801;4774.761261936889;4819.59033482151;4982.427020892644;4990.8752281193265;5105.600367827115;114926.4253678743;118136.40931795286;120805;121966;126252.36873815756;64824.35175648278;89727.55136224277;104771.47614262032;106428;107393;92691.76083214927;92787;94339.52830235806;94677;96911.51544242234;8852.822943541221;8856.955715221382;8949.463032218087;8960.372773905765;9051.637934482547;47729.761351193025;49713.751431242614;53937;54859.17711234414;56599.43400566106;49851;50463;60935.69532152311;67265.32734672591;77226;13922.930385348009;14280.928595356956;14321.64195895111;14501.854981450473;14505.492307769178;15487.225638718244;15494.380224791334;15572.68854622924;15927.362905483651;16293.185340732678;14355.425782968565;14489.855101448851;14734.778978315548;15040.699186016;15442.45951391696;14605.028321176505;14931.17878516692;14964.476243331432;15011.624709382353;15453.227338633249;13494.951895700524;14245.857541424453;14603.269836508345;14745.557633271019;15290.082595044332;11998.700032499257;12212.694682633006;12324.753504930031;12535.811962820748;12601.369931503572;11668.416579170838;11768.235064720766;12103.152779305365;12139.878601213875;12151.635450936486 04:00:11 INFO - PROCESS | 9401 | __end_tp_report 04:00:11 INFO - PROCESS | 9401 | __start_cc_report 04:00:11 INFO - PROCESS | 9401 | _x_x_mozilla_cycle_collect,327 04:00:11 INFO - PROCESS | 9401 | __end_cc_report 04:00:11 INFO - PROCESS | 9401 | __startTimestamp1470049211334__endTimestamp 04:00:11 INFO - PROCESS | 9401 | 04:00:11 INFO - PROCESS | 9401 | ------- Summary: start ------- 04:00:11 INFO - PROCESS | 9401 | Number of tests: 6 04:00:11 INFO - PROCESS | 9401 | 04:00:11 INFO - PROCESS | 9401 | [#0] dojo.html Cycles:165 Average:5704.72 Median:5961.34 stddev:659.06 (11.1%) stddev-sans-first:635.14 04:00:11 INFO - PROCESS | 9401 | Values: 3370.9 3385.9 3400.3 3437.2 3441.0 5646.7 5658.7 5673.7 5732.3 5742.0 5696.4 5733.2 5734.3 5743.9 5750.0 5081.1 5124.8 5171.2 5202.1 5211.3 5142.5 5158.0 5212.4 5217.3 5228.2 5170.2 5182.1 5223.6 5224.6 5255.2 5190.1 5207.8 5259.7 5265.9 5276.4 5155.7 5194.7 5272.2 5280.0 5284.8 5426.8 5443.8 5471.9 5482.1 5506.9 6032.1 6035.2 6055.4 6057.0 6058.9 5972.3 6106.8 6122.2 6125.7 6157.8 5631.4 5704.2 5705.6 5736.2 5761.1 6264.9 6275.0 6302.7 6310.6 6333.0 5902.4 5918.1 6048.8 6057.9 6062.5 5985.9 6111.7 6126.5 6138.8 6147.8 6054.5 6069.2 6074.1 6126.0 6131.8 5901.4 5980.6 6023.7 6070.8 6129.0 4585.1 4638.0 4643.5 4647.4 4667.9 4159.7 4168.5 4179.7 4180.3 4205.6 5916.5 5925.9 5949.0 5977.5 5988.5 6027.7 6066.4 6111.3 6130.6 6213.6 5958.3 5961.3 5962.6 5967.8 5989.6 5078.1 5149.9 5204.3 5232.6 5245.4 6485.8 6498.6 6512.6 6521.5 6525.5 6140.1 6222.0 6232.4 6234.3 6250.8 6459.4 6502.5 6545.1 6553.8 6571.7 6118.9 6148.5 6156.2 6164.9 6175.1 6074.3 6118.1 6132.1 6220.4 6280.7 6099.5 6105.1 6115.9 6122.1 6138.4 6042.9 6059.9 6068.1 6070.0 6072.7 5801.0 5802.0 5834.5 5876.9 5943.6 5972.2 6006.8 6007.5 6052.0 6066.5 5863.9 5915.4 5921.9 5924.8 5938.5 04:00:11 INFO - PROCESS | 9401 | 04:00:11 INFO - PROCESS | 9401 | [#1] ext.html Cycles:180 Average:62613.52 Median:45628.27 stddev:125131.38 (274.2%) stddev-sans-first:125395.78 04:00:11 INFO - PROCESS | 9401 | Values: 595.9 649.2 652.8 671.3 683.0 43764.0 48277.0 48327.0 48333.0 48386.8 48102.5 48308.3 48693.0 48702.0 48747.8 9001.1 9150.3 9173.0 9196.2 9196.8 9022.4 9028.2 9070.0 9123.1 9127.2 9090.7 9132.9 9151.2 9194.1 9208.2 9125.7 9131.0 9137.9 9157.5 9180.7 8980.5 9086.5 9089.3 9125.2 9137.0 43907.0 44454.8 44537.6 44607.8 44660.3 3674.9 3747.2 4336.1 4404.0 4481.7 35894.3 36022.5 36069.6 36127.1 36177.5 4635.6 4830.9 4841.5 4852.9 4868.7 282145.0 282808.0 283001.0 283635.0 285436.6 67202.7 67932.0 68025.3 68062.3 68093.7 40317.8 41006.0 41102.0 43134.4 71676.3 18489.6 18509.7 18599.4 18605.3 18678.2 13128.1 13142.1 13186.3 13220.8 13238.5 21701.9 21720.7 21965.1 21988.6 22035.4 7704.6 7861.3 7878.3 7991.7 8052.1 971.5 1042.9 1072.5 1104.1 1152.7 34777.3 34845.3 35269.5 35546.3 35628.8 1131.5 1156.6 1220.9 1239.5 1316.8 16965.6 17246.3 17266.7 17447.0 17601.8 607919.0 620118.0 633784.0 642220.0 650383.0 57336.7 63306.4 63493.7 63719.4 63788.0 1464.1 1500.4 1515.5 1521.0 1531.0 32889.5 32892.7 33512.5 33674.0 33763.0 55734.0 55953.0 56006.2 56276.4 56400.4 425770.0 428430.0 429431.0 429902.0 432877.0 30991.0 31246.0 31536.5 31624.4 31824.4 50644.5 50877.0 52036.2 52393.7 53574.5 44296.0 45810.5 46505.8 46558.0 47207.1 45446.0 46110.5 46310.8 47324.5 47824.8 46054.5 46054.8 46867.3 46954.8 47379.5 38988.2 39920.2 39978.6 40274.4 40830.6 30827.7 31156.4 31316.2 31561.2 31694.4 04:00:11 INFO - PROCESS | 9401 | 04:00:11 INFO - PROCESS | 9401 | [#2] jquery.html Cycles:180 Average:32147.50 Median:12719.98 stddev:96556.83 (759.1%) stddev-sans-first:96798.32 04:00:11 INFO - PROCESS | 9401 | Values: 430.8 433.7 434.4 434.9 440.0 19061.7 19700.8 19890.6 21397.3 21503.2 17512.5 18570.9 19581.4 19595.4 20348.5 5275.9 5461.2 5492.9 5497.1 5505.3 5365.5 5380.5 5447.7 5452.3 5484.8 5351.6 5381.7 5446.9 5460.4 5463.5 5394.8 5406.6 5443.2 5443.5 5447.5 5135.2 5240.8 5283.1 5293.0 5307.3 15162.3 18871.5 20129.7 23245.4 24006.6 2325.8 2947.4 3051.8 3082.7 3113.8 10084.8 10361.5 10693.6 10935.5 10998.3 2004.5 2017.1 2140.2 2143.7 2194.5 87145.6 89135.6 90452.5 94124.0 94243.0 9820.7 10377.8 10421.7 10446.2 11935.8 14440.1 14594.3 14621.9 14661.8 14708.7 8219.9 8263.4 8291.6 8320.8 8372.5 8002.7 8037.9 8112.6 8159.8 8197.4 4356.8 4471.5 4473.3 4477.7 4536.7 2152.6 2160.0 2163.6 2164.2 2175.7 966.8 1006.7 1016.5 1042.5 1079.5 19886.8 20001.8 20251.8 20461.4 20637.2 1027.3 1049.5 1049.9 1065.9 1081.9 11179.0 11368.1 11450.1 11540.8 11585.5 578297.0 580942.0 583381.0 598285.0 598529.0 61082.7 81772.0 86624.6 89759.6 91827.5 1067.4 1095.9 1107.9 1117.7 1118.7 18137.5 18560.5 18639.5 18697.0 18884.3 42552.6 44351.1 44609.6 45692.5 46265.3 63952.7 65025.0 66001.7 66287.7 66508.0 9042.9 9203.2 9273.9 9390.1 9490.0 13897.0 13920.9 14040.4 14125.9 14140.8 11718.6 12327.8 12425.9 12472.7 12570.5 11434.7 11580.1 11819.6 12038.2 12380.1 12333.4 12571.1 12812.7 12818.5 12922.4 9179.7 9186.1 9220.2 9318.8 9392.5 11946.3 12074.8 12182.8 12200.4 12225.9 04:00:11 INFO - PROCESS | 9401 | 04:00:11 INFO - PROCESS | 9401 | [#3] mootools.html Cycles:180 Average:6447.24 Median:4638.83 stddev:3764.97 (81.2%) stddev-sans-first:3757.72 04:00:11 INFO - PROCESS | 9401 | Values: 1573.2 1605.6 1825.5 1911.2 1926.2 8532.3 9395.3 9460.9 10110.8 10136.7 9457.7 9760.8 9824.4 9828.0 9849.7 2501.0 2530.1 2530.5 2531.4 2538.9 2437.3 2452.1 2470.2 2473.3 2482.2 2462.8 2464.3 2523.5 2530.2 2534.1 2460.5 2474.5 2477.9 2493.9 2494.4 2394.5 2408.3 2424.6 2429.6 2454.8 9682.4 9763.0 9792.0 9819.0 9835.1 5711.7 5854.6 5888.7 5933.8 5942.1 3672.6 3788.7 3850.7 3854.3 3864.0 1212.8 1216.0 1275.1 1311.9 1344.8 13218.6 13697.6 13731.9 14133.6 14361.6 4938.3 5002.3 5101.5 5101.8 5112.3 10884.9 10898.9 10953.2 10954.1 10956.8 5908.6 5909.3 5915.9 5925.1 5937.3 4666.0 5284.1 5345.4 5367.7 5430.5 4100.1 4111.0 4136.9 4159.3 4164.3 1241.3 1280.8 1287.9 1294.5 1300.0 952.9 1094.1 1095.2 1098.1 1110.7 6431.0 6576.3 6588.8 6634.1 6695.6 499.0 506.4 507.7 508.7 523.2 4494.0 4585.2 4588.7 4609.1 4611.7 12184.9 12478.9 12592.1 12659.3 12690.7 11616.8 12167.3 12221.8 12431.2 12451.2 9165.5 9175.9 9239.4 9304.4 9394.1 6461.8 6689.9 6886.6 6929.4 6933.8 11258.4 11412.6 11527.8 11833.1 11876.0 11693.5 11835.9 11862.2 11894.4 11970.2 7831.9 8540.6 8755.9 8838.9 8975.8 9867.0 9915.8 9919.3 9962.4 9975.2 7885.1 8374.4 8458.1 8625.3 8981.1 8497.1 8569.7 8580.9 8649.0 8691.6 7783.5 7816.1 7850.6 7887.9 7903.7 5501.1 5584.6 5620.6 5667.7 5753.8 5421.1 5461.7 5604.9 5744.0 5856.9 04:00:11 INFO - PROCESS | 9401 | 04:00:11 INFO - PROCESS | 9401 | [#4] prototype.html Cycles:180 Average:4856.08 Median:5417.67 stddev:1422.63 (26.3%) stddev-sans-first:1385.87 04:00:11 INFO - PROCESS | 9401 | Values: 352.0 352.6 356.8 358.8 359.1 5684.4 5687.3 5697.1 5766.6 5801.7 5626.9 5660.9 5666.4 5670.3 5677.3 4284.6 4366.7 4371.7 4375.6 4389.7 4351.2 4367.5 4420.8 4431.0 4441.8 4389.6 4409.9 4411.5 4418.9 4422.0 4194.2 4404.4 4406.7 4408.3 4429.6 3889.6 3892.1 3892.7 3901.2 3903.5 5363.8 5369.3 5439.9 5456.2 5460.6 4944.7 4997.4 5045.8 5053.5 5055.2 5865.0 5880.9 5895.4 5897.7 5897.8 4248.7 4258.2 4260.4 4264.5 4266.4 5967.2 5988.1 6109.7 6162.8 6197.6 4335.9 4338.6 4343.3 4343.6 4356.0 4373.2 4381.5 4401.3 4402.6 4407.3 4880.7 5029.5 5070.2 5090.0 5095.3 5933.8 5945.6 5962.5 5972.5 5982.7 1499.7 1507.4 1508.5 1509.6 1514.7 908.4 926.5 944.4 949.6 950.2 5126.2 5129.7 5130.2 5153.3 5195.5 5411.8 5437.4 5453.6 5470.9 5486.0 4981.4 5139.3 5159.4 5168.9 5172.4 2898.1 2916.5 2918.6 2920.5 2936.6 5586.9 5641.8 5652.7 5678.9 5702.3 5309.3 5443.3 5521.6 5561.2 5581.5 5612.2 5631.2 5651.5 5654.6 5738.7 5100.3 5335.5 5363.9 5423.5 5425.2 5312.1 5324.3 5356.3 5360.4 5762.7 6297.4 6414.5 6426.9 6443.6 6478.6 4178.6 4183.9 4203.7 4205.5 4216.3 5866.6 6137.8 6167.7 6205.3 6208.9 6013.3 6039.8 6061.2 6071.4 6087.1 5677.1 6022.6 6026.6 6045.4 6048.2 5945.3 5954.6 5969.4 5972.9 5994.4 6058.0 6067.0 6077.1 6088.6 6088.8 5525.7 5866.2 5876.8 5890.2 5947.3 04:00:11 INFO - PROCESS | 9401 | 04:00:11 INFO - PROCESS | 9401 | [#5] yui.html Cycles:180 Average:21309.47 Median:4139.91 stddev:30528.73 (737.4%) stddev-sans-first:30575.40 04:00:11 INFO - PROCESS | 9401 | Values: 764.4 784.7 812.3 820.1 839.0 16153.5 16348.6 16555.0 16582.0 16610.8 15296.7 15545.3 15548.8 15556.5 15618.4 708.6 842.9 859.5 864.3 866.2 854.4 854.8 859.1 861.3 863.3 912.9 915.8 917.6 917.6 919.4 904.1 905.2 905.9 907.0 908.9 664.5 667.3 668.7 669.5 669.9 15801.7 15801.7 15859.8 15894.7 15960.8 14061.4 15592.7 16169.1 16529.3 16561.4 12176.0 12524.7 13687.9 13688.0 13963.1 4000.7 4033.4 4036.5 4070.8 4209.1 82389.6 82672.2 82776.6 83702.0 85936.1 11811.3 12009.0 12109.9 12265.8 12295.1 18987.2 20090.2 20202.4 20650.9 21020.6 8694.6 8779.4 8837.2 9102.2 9167.5 4757.7 4764.7 4777.1 4778.6 4947.4 3765.8 3869.8 3873.7 3884.5 3885.9 619.9 671.2 675.7 675.8 677.1 641.3 677.2 725.9 730.8 742.4 9984.4 10116.8 10334.4 10469.4 10490.4 689.5 704.5 707.9 708.7 725.8 4774.8 4819.6 4982.4 4990.9 5105.6 114926.4 118136.4 120805.0 121966.0 126252.4 64824.4 89727.6 104771.5 106428.0 107393.0 92691.8 92787.0 94339.5 94677.0 96911.5 8852.8 8857.0 8949.5 8960.4 9051.6 47729.8 49713.8 53937.0 54859.2 56599.4 49851.0 50463.0 60935.7 67265.3 77226.0 13922.9 14280.9 14321.6 14501.9 14505.5 15487.2 15494.4 15572.7 15927.4 16293.2 14355.4 14489.9 14734.8 15040.7 15442.5 14605.0 14931.2 14964.5 15011.6 15453.2 13495.0 14245.9 14603.3 14745.6 15290.1 11998.7 12212.7 12324.8 12535.8 12601.4 11668.4 11768.2 12103.2 12139.9 12151.6 04:00:11 INFO - PROCESS | 9401 | -------- Summary: end -------- 04:00:11 INFO - PROCESS | 9401 | 04:00:12 INFO - TEST-INFO | 9401: exit 0 04:00:12 INFO - TEST-OK | dromaeo_css | took 1109899ms 04:00:12 INFO - TEST-START | kraken 04:00:12 INFO - operating with platform_type : linux_ 04:00:12 INFO - Initialising browser for kraken test... 04:00:12 INFO - TEST-INFO | started process 9641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgTvRZU/profile http://localhost:48471/getInfo.html) 04:00:16 INFO - PROCESS | 9641 | __metrics Screen width/height:1600/1200 04:00:16 INFO - PROCESS | 9641 | colorDepth:24 04:00:16 INFO - PROCESS | 9641 | Browser inner width/height: 1024/697 04:00:16 INFO - PROCESS | 9641 | __metrics 04:00:17 ERROR - PROCESS | 9641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:00:17 INFO - TEST-INFO | 9641: exit 0 04:00:17 INFO - Browser initialized. 04:00:17 INFO - Running cycle 1/1 for kraken test... 04:00:17 INFO - TEST-INFO | started process 9772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgTvRZU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:29 INFO - PROCESS | 9772 | RSS: Main: 153559040 04:00:29 INFO - PROCESS | 9772 | 04:00:32 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48471/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:32 INFO - PROCESS | 9772 | RSS: Main: 159399936 04:00:32 INFO - PROCESS | 9772 | 04:00:35 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48471/tests/kraken/driver.html?testName=audio-dft) 04:00:36 INFO - PROCESS | 9772 | RSS: Main: 158629888 04:00:36 INFO - PROCESS | 9772 | 04:00:39 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48471/tests/kraken/driver.html?testName=audio-fft) 04:00:39 INFO - PROCESS | 9772 | RSS: Main: 159100928 04:00:39 INFO - PROCESS | 9772 | 04:00:41 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48471/tests/kraken/driver.html?testName=audio-oscillator) 04:00:42 INFO - PROCESS | 9772 | RSS: Main: 158908416 04:00:42 INFO - PROCESS | 9772 | 04:00:44 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48471/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:45 INFO - PROCESS | 9772 | RSS: Main: 158658560 04:00:45 INFO - PROCESS | 9772 | 04:00:48 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48471/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:48 INFO - PROCESS | 9772 | RSS: Main: 158322688 04:00:48 INFO - PROCESS | 9772 | 04:00:52 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48471/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:52 INFO - PROCESS | 9772 | RSS: Main: 159625216 04:00:52 INFO - PROCESS | 9772 | 04:00:55 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48471/tests/kraken/driver.html?testName=json-parse-financial) 04:00:56 INFO - PROCESS | 9772 | RSS: Main: 159465472 04:00:56 INFO - PROCESS | 9772 | 04:00:57 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48471/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:58 INFO - PROCESS | 9772 | RSS: Main: 159682560 04:00:58 INFO - PROCESS | 9772 | 04:01:00 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48471/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:01:00 INFO - PROCESS | 9772 | RSS: Main: 159465472 04:01:00 INFO - PROCESS | 9772 | 04:01:03 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48471/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:01:03 INFO - PROCESS | 9772 | RSS: Main: 159686656 04:01:03 INFO - PROCESS | 9772 | 04:01:06 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:01:06 INFO - PROCESS | 9772 | RSS: Main: 160063488 04:01:06 INFO - PROCESS | 9772 | 04:01:09 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:01:10 INFO - PROCESS | 9772 | RSS: Main: 159952896 04:01:10 INFO - PROCESS | 9772 | 04:01:11 INFO - PROCESS | 9772 | Cycle 1(1): loaded http://localhost:48471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48471/tests/kraken/driver.html?testName=ai-astar) 04:01:12 INFO - PROCESS | 9772 | RSS: Main: 160600064 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | __start_tp_report 04:01:12 INFO - PROCESS | 9772 | _x_x_mozilla_page_load 04:01:12 INFO - PROCESS | 9772 | _x_x_mozilla_page_load_details 04:01:12 INFO - PROCESS | 9772 | |i|pagename|runs| 04:01:12 INFO - PROCESS | 9772 | |0;ai-astar;110;104;111;110;111;110;110;109;108;110 04:01:12 INFO - PROCESS | 9772 | |1;audio-beat-detection;155;126;158;184;125;154;164;125;186;127 04:01:12 INFO - PROCESS | 9772 | |2;audio-dft;160;161;160;160;162;162;162;162;170;161 04:01:12 INFO - PROCESS | 9772 | |3;audio-fft;75;76;75;186;76;74;76;76;159;77 04:01:12 INFO - PROCESS | 9772 | |4;audio-oscillator;84;84;145;85;85;85;145;86;85;138 04:01:12 INFO - PROCESS | 9772 | |5;imaging-gaussian-blur;118;117;117;116;117;117;117;117;118;117 04:01:12 INFO - PROCESS | 9772 | |6;imaging-darkroom;147;148;148;148;146;148;147;148;147;148 04:01:12 INFO - PROCESS | 9772 | |7;imaging-desaturate;95;96;99;95;96;95;95;96;96;95 04:01:12 INFO - PROCESS | 9772 | |8;json-parse-financial;54;55;57;56;57;57;62;55;55;55 04:01:12 INFO - PROCESS | 9772 | |9;json-stringify-tinderbox;61;60;60;61;61;60;60;60;60;60 04:01:12 INFO - PROCESS | 9772 | |10;stanford-crypto-aes;77;82;79;79;78;77;81;77;108;83 04:01:12 INFO - PROCESS | 9772 | |11;stanford-crypto-ccm;126;121;127;117;138;134;121;121;128;128 04:01:12 INFO - PROCESS | 9772 | |12;stanford-crypto-pbkdf2;153;158;154;153;155;159;155;154;153;157 04:01:12 INFO - PROCESS | 9772 | |13;stanford-crypto-sha256-iterative;62;64;63;62;63;65;62;61;61;65 04:01:12 INFO - PROCESS | 9772 | __end_tp_report 04:01:12 INFO - PROCESS | 9772 | __start_cc_report 04:01:12 INFO - PROCESS | 9772 | _x_x_mozilla_cycle_collect,871 04:01:12 INFO - PROCESS | 9772 | __end_cc_report 04:01:12 INFO - PROCESS | 9772 | __startTimestamp1470049272045__endTimestamp 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | ------- Summary: start ------- 04:01:12 INFO - PROCESS | 9772 | Number of tests: 14 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.06 (1.9%) stddev-sans-first:2.17 04:01:12 INFO - PROCESS | 9772 | Values: 110.0 104.0 111.0 110.0 111.0 110.0 110.0 109.0 108.0 110.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:156.50 stddev:23.82 (15.2%) stddev-sans-first:25.21 04:01:12 INFO - PROCESS | 9772 | Values: 155.0 126.0 158.0 184.0 125.0 154.0 164.0 125.0 186.0 127.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:2.94 (1.8%) stddev-sans-first:3.03 04:01:12 INFO - PROCESS | 9772 | Values: 160.0 161.0 160.0 160.0 162.0 162.0 162.0 162.0 170.0 161.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:41.35 (54.4%) stddev-sans-first:43.22 04:01:12 INFO - PROCESS | 9772 | Values: 75.0 76.0 75.0 186.0 76.0 74.0 76.0 76.0 159.0 77.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:85.00 stddev:28.00 (32.9%) stddev-sans-first:28.91 04:01:12 INFO - PROCESS | 9772 | Values: 84.0 84.0 145.0 85.0 85.0 85.0 145.0 86.0 85.0 138.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 04:01:12 INFO - PROCESS | 9772 | Values: 118.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:01:12 INFO - PROCESS | 9772 | Values: 147.0 148.0 148.0 148.0 146.0 148.0 147.0 148.0 147.0 148.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.23 (1.3%) stddev-sans-first:1.27 04:01:12 INFO - PROCESS | 9772 | Values: 95.0 96.0 99.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:2.26 (4.0%) stddev-sans-first:2.24 04:01:12 INFO - PROCESS | 9772 | Values: 54.0 55.0 57.0 56.0 57.0 57.0 62.0 55.0 55.0 55.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 04:01:12 INFO - PROCESS | 9772 | Values: 61.0 60.0 60.0 61.0 61.0 60.0 60.0 60.0 60.0 60.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:79.00 stddev:9.35 (11.8%) stddev-sans-first:9.73 04:01:12 INFO - PROCESS | 9772 | Values: 77.0 82.0 79.0 79.0 78.0 77.0 81.0 77.0 108.0 83.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:127.50 stddev:6.44 (5.0%) stddev-sans-first:6.83 04:01:12 INFO - PROCESS | 9772 | Values: 126.0 121.0 127.0 117.0 138.0 134.0 121.0 121.0 128.0 128.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.00 stddev:2.18 (1.4%) stddev-sans-first:2.18 04:01:12 INFO - PROCESS | 9772 | Values: 153.0 158.0 154.0 153.0 155.0 159.0 155.0 154.0 153.0 157.0 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - PROCESS | 9772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.48 (2.3%) stddev-sans-first:1.54 04:01:12 INFO - PROCESS | 9772 | Values: 62.0 64.0 63.0 62.0 63.0 65.0 62.0 61.0 61.0 65.0 04:01:12 INFO - PROCESS | 9772 | -------- Summary: end -------- 04:01:12 INFO - PROCESS | 9772 | 04:01:12 INFO - TEST-INFO | 9772: exit 0 04:01:12 INFO - TEST-OK | kraken | took 60956ms 04:01:12 INFO - SUITE-END | took 1170s 04:01:13 INFO - Completed test suite (00:19:31) 04:01:13 INFO - javascript benchmark 04:01:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7664.62750378382, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.8820191293307, 3385.8645654173833, 3400.251944572193, 3437.157896315403, 3441.0365097772615, 5646.7176641167935, 5658.688772117532, 5673.659580425172, 5732.312122545301, 5741.971290143543, 5696.3733989261145, 5733.197352370671, 5734.340550836655, 5743.913841292384, 5749.971250143743, 5081.1108056090125, 5124.795008199686, 5171.22431635254, 5202.141646628321, 5211.322528071364, 5142.485751424865, 5158.0199762045095, 5212.374515058179, 5217.295665085222, 5228.189630607262, 5170.224466330062, 5182.067227898977, 5223.582113430916, 5224.582033437316, 5255.237990491377, 5190.11767999441, 5207.765650545734, 5259.684418934876, 5265.947340526584, 5276.419593844674, 5155.71643559604, 5194.68831870089, 5272.209168624699, 5280.0, 5284.81503147388, 5426.810061647863, 5443.782248710047, 5471.917921231185, 5482.122860342366, 5506.889862202774, 6032.065029920369, 6035.245594300713, 6055.424734650202, 6057.0, 6058.909116363258, 5972.25346831646, 6106.755729770804, 6122.173506576644, 6125.693715314261, 6157.78447754331, 5631.380548139701, 5704.201411802351, 5705.62913410627, 5736.2256095427, 5761.135829625548, 6264.906026409608, 6274.968625156845, 6302.65335406557, 6310.558260921692, 6332.968335158294, 5902.409759024149, 5918.082697181943, 6048.848778780478, 6057.939420605826, 6062.545309101835, 5985.850353741192, 6111.708054759659, 6126.533375816431, 6138.754449821957, 6147.754089836446, 6054.485368743706, 6069.241344831896, 6074.058520929263, 6126.0, 6131.754729810757, 5901.439363260483, 5980.641161530322, 6023.69881505923, 6070.787522436782, 6128.9693551531955, 4585.12882552314, 4638.0, 4643.489216186217, 4647.419072615923, 4667.8599642010795, 4159.667226621863, 4168.458100446983, 4179.686523510749, 4180.331147016524, 4205.558416366238, 5916.467517923407, 5925.911111333334, 5949.0481522956115, 5977.521798256129, 5988.520918326523, 6027.7287522061615, 6066.423689749467, 6111.348653136725, 6130.6467468051915, 6213.565050446426, 5958.255218097738, 5961.344252132262, 5962.642241465526, 5967.791127310524, 5989.610675306091, 5078.13671675816, 5149.948500515022, 5204.34945631796, 5232.633715639869, 5245.423003469616, 6485.77299794505, 6498.6425746583445, 6512.5766825156215, 6521.47828173745, 6525.543211975211, 6140.109684095871, 6222.0, 6232.376762323732, 6234.2830574484515, 6250.781222657185, 6459.354064593503, 6502.479801615765, 6545.116409284686, 6553.803385898431, 6571.737130514726, 6118.938810612015, 6148.4773794227995, 6156.199694039925, 6164.907526387018, 6175.135481032569, 6074.301455332693, 6118.143459915526, 6132.110769107885, 6220.440160385587, 6280.654563998841, 6099.451049405575, 6105.053716673922, 6115.879294474783, 6122.123558664931, 6138.386161383826, 6042.8791424170395, 6059.909101363572, 6068.059450785136, 6070.028795392716, 6072.666003369857, 5800.970995144998, 5801.970990145022, 5834.533237340917, 5876.911846322223, 5943.554233432424, 5972.223610930551, 6006.849828754316, 6007.519398448201, 6052.0, 6066.4540191382985, 5863.941360586339, 5915.378885217162, 5921.85195370102, 5924.792632258022, 5938.495227905676], "value": 5660.295247227799, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.856994321363, 649.172305310729, 652.7943697735213, 671.3253180553542, 682.9925859357452, 43764.0, 48276.999999999956, 48327.0, 48333.0, 48386.75806620962, 48102.51897481024, 48308.27537586939, 48693.0, 48702.0, 48747.75626121873, 9001.054889236633, 9150.313726470507, 9173.036831132735, 9196.172344488994, 9196.816063678722, 9022.413543119708, 9028.187463128317, 9070.0, 9123.133302336268, 9127.224185944202, 9090.727278181632, 9132.863007054899, 9151.222146117554, 9194.08059194082, 9208.217301529377, 9125.72622821313, 9131.041240669734, 9137.862932056025, 9157.496337701425, 9180.6786762463, 8980.506072166028, 9086.45481271126, 9089.27285817133, 9125.224355929753, 9137.04061073591, 43907.0, 44454.77772611116, 44537.55462445367, 44607.77696111531, 44660.3300950486, 3674.8713795017316, 3747.2318174774377, 4336.111097225062, 4404.0, 4481.6638752093395, 35894.282114357564, 36022.45966310507, 36069.63930360689, 36127.096822579384, 36177.457338139946, 4635.629149668019, 4830.855074347775, 4841.467438581753, 4852.8544143675745, 4868.659193856396, 282145.0, 282808.0, 283001.0, 283635.0, 285436.57281713665, 67202.66398667975, 67932.0, 68025.31974680288, 68062.31937680658, 68093.65953170203, 40317.79841100776, 41006.0, 41102.0, 43134.352984705256, 71676.28323716696, 18489.630207396047, 18509.7223541647, 18599.44201673952, 18605.255789768256, 18678.159482823306, 13128.146670466389, 13142.145760525535, 13186.274754888573, 13220.801687974688, 13238.470461181445, 21701.891490542446, 21720.674189887166, 21965.121395144015, 21988.560228795333, 22035.449113771963, 7704.614769261514, 7861.278606791226, 7878.322904627162, 7991.72028978983, 8052.114267430578, 971.489967766928, 1042.8748550174028, 1072.4905669806778, 1104.13877175803, 1152.677250369881, 34777.30445391078, 34845.30309393798, 35269.47095793565, 35546.28907421837, 35628.82185589056, 1131.5191043806515, 1156.6240971684235, 1220.859601145862, 1239.4794186441716, 1316.782730849399, 16965.575860603338, 17246.310147593955, 17266.65466690684, 17447.0, 17601.823981760273, 607919.0, 620118.0, 633784.0, 642220.0, 650383.0, 57336.71331643315, 63306.36693633005, 63493.68253158797, 63719.36280637227, 63788.0, 1464.1068947941747, 1500.3998400639614, 1515.5301856424323, 1520.9543713688606, 1530.9770353444708, 32889.506657400634, 32892.671073289916, 33512.49731253985, 33674.0, 33763.0, 55734.0, 55953.0, 56006.1599076006, 56276.43723562712, 56400.43599564116, 425770.0, 428430.0, 429431.0, 429902.0, 432877.0, 30991.0, 31246.0, 31536.526952096196, 31624.36751265008, 31824.408779561392, 50644.49355506398, 50877.0, 52036.21945670894, 52393.7380313096, 53574.46425535851, 44296.0, 45810.54189458063, 46505.76747116243, 46558.0, 47207.055858883316, 45446.0, 46110.538894610625, 46310.768446157555, 47324.52675473201, 47824.760876195396, 46054.53945460502, 46054.76972615116, 46867.29699054585, 46954.76522617365, 47379.526204737514, 38988.2202355957, 39920.2015959685, 39978.60021399865, 40274.395884061174, 40830.59169408268, 30827.691723082484, 31156.37687246288, 31316.217094572818, 31561.21096972594, 31694.36611267808], "value": 21478.448029783773, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.80183115766744, 433.71808324589017, 434.4260694691217, 434.85432380152645, 439.9802008909601, 19061.71407428888, 19700.802991970093, 19890.602187956232, 21397.251096211636, 21503.24738634144, 17512.474625761246, 18570.907145464287, 19581.412557623295, 19595.41213763586, 20348.491287717778, 5275.894482110355, 5461.208124821898, 5492.945070549284, 5497.092979658351, 5505.256790333294, 5365.463453654643, 5380.542653874406, 5447.673139611636, 5452.291202143736, 5484.8354549363585, 5351.625386222966, 5381.704006279653, 5446.863828404302, 5460.399356070829, 5463.453654634544, 5394.811181608645, 5406.59450541207, 5443.2107344435235, 5443.455654434564, 5447.4824891635235, 5135.204043373283, 5240.842774716764, 5283.128283833163, 5293.04725149473, 5307.2569840222395, 15162.31769570361, 18871.528211794677, 20129.698054529195, 23245.418864528354, 24006.639900401507, 2325.848819826706, 2947.3810499795068, 3051.771117166199, 3082.6917308269217, 3113.7820352575327, 10084.848727269096, 10361.533730982124, 10693.572257109707, 10935.507902144423, 10998.34009959405, 2004.5489764802949, 2017.0923084611984, 2140.154638917634, 2143.689165071056, 2194.5391467791783, 87145.56427217886, 89135.55432222862, 90452.54773726156, 94124.0, 94242.99999999932, 9820.65627703027, 10377.84433233502, 10421.68734937953, 10446.164306855586, 11935.761284774257, 14440.061396009225, 14594.34325455357, 14621.853781462049, 14661.780073298909, 14708.705825883637, 8219.876701849476, 8263.421560490708, 8291.626876790559, 8320.83358332842, 8372.455790373606, 8002.679892804339, 8037.879431808527, 8112.594370281462, 8159.79600509992, 8197.385196110316, 4356.803943822472, 4471.5081341052455, 4473.329000649928, 4477.7313361197785, 4536.705114167568, 2152.5910077085305, 2159.978400216009, 2163.556470923457, 2164.177612507237, 2175.7171567696414, 966.8308046092046, 1006.7332156978407, 1016.4714348538719, 1042.5152304178594, 1079.4926384599225, 19886.801131988785, 20001.799982000284, 20251.79748202499, 20461.386158415273, 20637.17451301961, 1027.3476342522404, 1049.5172220778375, 1049.9265051446325, 1065.9200559957878, 1081.8972197641212, 11179.049780768562, 11368.147388945863, 11450.141239407078, 11540.845915408392, 11585.478653460614, 578297.0, 580942.0, 583381.0, 598285.0, 598529.0, 61082.694586526784, 81772.0, 86624.56687716646, 89759.55120224488, 91827.54086229659, 1067.4182570499097, 1095.8630171228597, 1107.9335239885634, 1117.698221480212, 1118.6532175025604, 18137.455876323733, 18560.535986600444, 18639.534011649273, 18697.0, 18884.3390481338, 42552.5744742561, 44351.11297774091, 44609.55390446054, 45692.54307456883, 46265.3060204104, 63952.68023660038, 65025.0, 66001.66999164973, 66287.66856165689, 66508.0, 9042.864357034518, 9203.217726493323, 9273.907260927574, 9390.060993900555, 9490.0, 13897.0, 13920.930395348363, 14040.368183431974, 14125.929370353082, 14140.78788818189, 11718.648440546796, 12327.815082773945, 12425.875741242471, 12472.690367511643, 12570.497180112692, 11434.714132146762, 11580.131490138105, 11819.586314478953, 12038.157328986887, 12380.133390662568, 12333.444994975427, 12571.1200215984, 12812.654671259383, 12818.493560349252, 12922.353882305659, 9179.678711245075, 9186.127317904788, 9220.216281616138, 9318.767030824283, 9392.530373481162, 11946.283223006647, 12074.818877717016, 12182.75634487323, 12200.389980501117, 12225.877741222474], "value": 9537.739791795684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.1819453883984, 1605.6226786705122, 1825.543614096476, 1911.2259534888376, 1926.162119478028, 8532.317414606832, 9395.34232603718, 9460.85808712869, 10110.797784044324, 10136.746581335461, 9457.668981585646, 9760.755981100476, 9824.361416507922, 9828.0, 9849.65526206583, 2501.0496011515597, 2530.051230788454, 2530.544501989641, 2531.3798119460757, 2538.923832285025, 2437.2810021043747, 2452.1049816816912, 2470.1601455505124, 2473.3445636906235, 2482.156066937241, 2462.8029757619347, 2464.3346296499935, 2523.470071285032, 2530.202986059395, 2534.1130604288537, 2460.5324988252264, 2474.480359124586, 2477.913273035444, 2493.9376515587073, 2494.3888747256856, 2394.473215892518, 2408.2654790288957, 2424.5635785558593, 2429.6112621980396, 2454.754524547549, 9682.419054856731, 9763.0, 9792.0, 9818.950905245429, 9835.114839664464, 5711.742971566248, 5854.560907931879, 5888.735006924699, 5933.792317268918, 5942.108683697436, 3672.59601443841, 3788.6969042476812, 3850.7111966602615, 3854.3062248795204, 3863.97604634772, 1212.799888018476, 1215.9878401215963, 1275.101053757099, 1311.8753718396738, 1344.8184495093233, 13218.60344189676, 13697.589072327746, 13731.862681373259, 14133.575992720234, 14361.569152925429, 4938.259261110862, 5002.299678045077, 5101.5408613224245, 5101.770420331094, 5112.309838171874, 10884.891151088546, 10898.945505272422, 10953.17851161166, 10954.068904143238, 10956.835647465294, 5908.556858235564, 5909.2908850938165, 5915.852103697442, 5925.081612350093, 5937.2578427696535, 4666.0, 5284.101702710548, 5345.3852806926925, 5367.704776237267, 5430.484104010113, 4100.138970816102, 4111.030750430255, 4136.875893723193, 4159.313713237282, 4164.271252530795, 1241.3420886929941, 1280.775864223757, 1287.9162854414433, 1294.4692676002794, 1299.9870001300055, 952.9047095290554, 1094.1137678480457, 1095.1731442760824, 1098.1379617000775, 1110.666799960025, 6431.0, 6576.276609572943, 6588.802335929834, 6634.0712300278, 6695.598264104169, 499.0, 506.4150905703918, 507.6776247083055, 508.7456271864068, 523.1995047577213, 4493.955060449353, 4585.174668559691, 4588.701734387254, 4609.101225261109, 4611.654125940568, 12184.939075304566, 12478.875211247952, 12592.055595830167, 12659.303738294482, 12690.746185076247, 11616.767664646659, 12167.33079680626, 12221.75556488883, 12431.191972521758, 12451.190672606252, 9165.541722913827, 9175.908240917506, 9239.445633262027, 9304.441733495876, 9394.06059394055, 6461.773837915651, 6689.933100668931, 6886.552374095868, 6929.376356127771, 6933.757318493828, 11258.437078145897, 11412.600558980395, 11527.827082593936, 11833.112516561465, 11876.049916006526, 11693.473793679135, 11835.940820295844, 11862.169648124549, 11894.405279736151, 11970.162088654059, 7831.921680783119, 8540.615672294885, 8755.91244087551, 8838.867416988622, 8975.775605609912, 9867.0, 9915.752106197402, 9919.256055795988, 9962.352447090916, 9975.20198384113, 7885.132635409986, 8374.371922105745, 8458.111898250841, 8625.266852317372, 8981.14679105484, 8497.107803680525, 8569.700060497853, 8580.871286930826, 8649.0, 8691.608877600396, 7783.532988020737, 7816.140224575179, 7850.646720897687, 7887.921120788948, 7903.695890178056, 5501.092319767194, 5584.609077364546, 5620.606557540933, 5667.716614169358, 5753.827385178452, 5421.132618780976, 5461.726913654381, 5604.943950560605, 5744.0, 5856.882862342814], "value": 5027.665498334819, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.03191224133633, 352.5733862026948, 356.80910712768656, 358.8026585378041, 359.1219468399762, 5684.436779885534, 5687.2606561147095, 5697.116946873236, 5766.567507436948, 5801.738921748521, 5626.859328516789, 5660.915086273699, 5666.376698563155, 5670.262865827447, 5677.318721753385, 4284.550122237167, 4366.67249956253, 4371.737695738266, 4375.6499480041675, 4389.7146685465505, 4351.238533256684, 4367.475902891658, 4420.845270415536, 4431.02517446163, 4441.844535441261, 4389.648828093761, 4409.911801763963, 4411.4706235251815, 4418.911621767563, 4422.049259409227, 4194.182134483777, 4404.4494438195225, 4406.713563618387, 4408.316710909814, 4429.623482004034, 3889.572147063821, 3892.1437283797804, 3892.727509074366, 3901.239258344624, 3903.5315762108444, 5363.839084827461, 5369.328833895763, 5439.945600543983, 5456.181572764078, 5460.6177567570285, 4944.703317800908, 4997.350344455234, 5045.772940217699, 5053.545180933734, 5055.191169412877, 5865.0, 5880.852978675524, 5895.35151133375, 5897.734601942923, 5897.764089436418, 4248.681348898845, 4258.189594867404, 4260.424842646234, 4264.530901600821, 4266.445362102938, 5967.19442875215, 5988.131720900445, 6109.725062372204, 6162.815115546541, 6197.597156184878, 4335.913281734348, 4338.609525142752, 4343.262694921993, 4343.609075183249, 4356.041670832412, 4373.169097871394, 4381.474223093249, 4401.273789824707, 4402.603765661106, 4407.2507673695545, 4880.682755620874, 5029.471905449948, 5070.2141168119, 5090.007448547498, 5095.261187127846, 5933.792317268875, 5945.613535120204, 5962.509372656836, 5972.492338151219, 5982.670953097621, 1499.71505413971, 1507.3970411835353, 1508.4871143811156, 1509.562226954171, 1514.719776841288, 908.418612088264, 926.5459924637014, 944.3814301632442, 949.5869296855751, 950.1923365139576, 5126.205827960184, 5129.692218466904, 5130.204818253177, 5153.252778347119, 5195.454477279907, 5411.836455162081, 5437.401885792559, 5453.64551304164, 5470.890582188414, 5486.0, 4981.430849282465, 5139.280500729901, 5159.39450577456, 5168.948310516922, 5172.405173405032, 2898.0581311073984, 2916.4750344938116, 2918.6059881916094, 2920.53271476567, 2936.6182396288345, 5586.888262234733, 5641.802536911188, 5652.7173641318595, 5678.854436261552, 5702.344230413472, 5309.256704061435, 5443.346798384219, 5521.585881058937, 5561.220409468931, 5581.49766521015, 5612.242347283064, 5631.183478395692, 5651.463111004448, 5654.575906807006, 5738.713064346766, 5100.311457953278, 5335.478584134453, 5363.892722145613, 5423.511883930465, 5425.240466334795, 5312.096943519534, 5324.307839980777, 5356.250124982584, 5360.42699504248, 5762.740676669644, 6297.433231009231, 6414.486841052798, 6426.903596445964, 6443.613383197023, 6478.611283323015, 4178.597306548686, 4183.937240941327, 4203.705740598129, 4205.474315710536, 4216.3464662977285, 5866.5893387462465, 6137.84655383619, 6167.660778657217, 6205.2553693557065, 6208.937910620836, 6013.278406591237, 6039.795474651808, 6061.212042434456, 6071.392860713893, 6087.052143314097, 5677.063284558167, 6022.608530445507, 6026.578139530191, 6045.370263935202, 6048.213732214784, 5945.286565612154, 5954.612950158225, 5969.403059693996, 5972.8805423892145, 5994.370591088047, 6057.969710151421, 6066.9696651518225, 6077.088436734349, 6088.6042407243385, 6088.817335479943, 5525.696086715269, 5866.208061911588, 5876.764929402947, 5890.204822348928, 5947.345791962967], "value": 4402.536401031315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.4266799900075, 784.697891311845, 812.3257696112225, 820.052838970988, 839.0476808821988, 16153.515394538168, 16348.591285217875, 16555.0, 16582.0, 16610.75083873743, 15296.69406611867, 15545.30046147926, 15548.84451155488, 15556.533304000897, 15618.375264989387, 708.606723268587, 842.877782721505, 859.5143743784773, 864.2610567964363, 866.1857853617611, 854.3805740837905, 854.799122206281, 859.1108203009886, 861.3195575495382, 863.3352318714586, 912.8950170730351, 915.7985243246509, 917.5504003038529, 917.5824999625155, 919.429953428875, 904.0552622509427, 905.1988989744091, 905.9094090590921, 907.0294784580534, 908.9409188402733, 664.5281849886586, 667.2593421302399, 668.7425341243608, 669.5079116849112, 669.9263081061129, 15801.683966320725, 15801.683966320725, 15859.841401585953, 15894.682106357925, 15960.76058859118, 14061.437542498288, 15592.666005946481, 16169.110698911556, 16529.256183471774, 16561.42035028768, 12176.0, 12524.686882827911, 13687.863121368759, 13688.0, 13963.092398994033, 4000.739951903117, 4033.415154802537, 4036.4752582164133, 4070.7557546547005, 4209.074003719177, 82389.58805205996, 82672.17327826704, 82776.58611706903, 83702.0, 85936.14063859344, 11811.271533306339, 12009.0, 12109.878901211052, 12265.754684906253, 12295.077869159848, 18987.24051037943, 20090.196392144444, 20202.393928182177, 20650.89674551648, 21020.579588408145, 8694.608742606599, 8779.429337093068, 8837.248833849066, 9102.226310763659, 9167.495787731605, 4757.666963312604, 4764.666473346832, 4777.0684716479955, 4778.641601879873, 4947.356843610308, 3765.8305376258136, 3869.8258578364043, 3873.709471789627, 3884.4755957945317, 3885.902852428712, 619.8574327904518, 671.2314400011959, 675.7499725101645, 675.8411773233287, 677.1028387386634, 641.3298103481873, 677.2178134254943, 725.8584576007628, 730.7807657702668, 742.354151887861, 9984.400935943866, 10116.797664046826, 10334.379937203792, 10469.371837689763, 10490.423026733602, 689.4794430205263, 704.475166001322, 707.8761216787042, 708.6563016936782, 725.7750097469801, 4774.761261936889, 4819.59033482151, 4982.427020892644, 4990.8752281193265, 5105.600367827115, 114926.4253678743, 118136.40931795286, 120805.0, 121966.0, 126252.36873815756, 64824.35175648278, 89727.55136224277, 104771.47614262032, 106428.0, 107393.0, 92691.76083214927, 92787.0, 94339.52830235806, 94677.0, 96911.51544242234, 8852.822943541221, 8856.955715221382, 8949.463032218087, 8960.372773905765, 9051.637934482547, 47729.761351193025, 49713.751431242614, 53937.0, 54859.17711234414, 56599.43400566106, 49851.0, 50463.0, 60935.69532152311, 67265.32734672591, 77226.0, 13922.930385348009, 14280.928595356956, 14321.64195895111, 14501.854981450473, 14505.492307769178, 15487.225638718244, 15494.380224791334, 15572.68854622924, 15927.362905483651, 16293.185340732678, 14355.425782968565, 14489.855101448851, 14734.778978315548, 15040.699186016, 15442.45951391696, 14605.028321176505, 14931.17878516692, 14964.476243331432, 15011.624709382353, 15453.227338633249, 13494.951895700524, 14245.857541424453, 14603.269836508345, 14745.557633271019, 15290.082595044332, 11998.700032499257, 12212.694682633006, 12324.753504930031, 12535.811962820748, 12601.369931503572, 11668.416579170838, 11768.235064720766, 12103.152779305365, 12139.878601213875, 12151.635450936486], "value": 7898.543747943139, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 111.0, 110.0, 111.0, 110.0, 110.0, 109.0, 108.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 158.0, 184.0, 125.0, 154.0, 164.0, 125.0, 186.0, 127.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 162.0, 162.0, 162.0, 162.0, 170.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 186.0, 76.0, 74.0, 76.0, 76.0, 159.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 145.0, 85.0, 85.0, 85.0, 145.0, 86.0, 85.0, 138.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 146.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 99.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 56.0, 57.0, 57.0, 62.0, 55.0, 55.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 82.0, 79.0, 79.0, 78.0, 77.0, 81.0, 77.0, 108.0, 83.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 121.0, 127.0, 117.0, 138.0, 134.0, 121.0, 121.0, 128.0, 128.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 158.0, 154.0, 153.0, 155.0, 159.0, 155.0, 154.0, 153.0, 157.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 62.0, 63.0, 65.0, 62.0, 61.0, 61.0, 65.0], "value": 62.8, "unit": "score"}]}]} 04:01:13 INFO - Return code: 0 04:01:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:01:13 ERROR - # TBPL SUCCESS # 04:01:13 INFO - Running post-action listener: _resource_record_post_action 04:01:13 INFO - ##### 04:01:13 INFO - ##### Finished run-tests step (success) 04:01:13 INFO - ##### 04:01:13 INFO - Running post-run listener: _resource_record_post_run 04:01:13 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 492601344; Read time: 20; Write time: 467716 04:01:13 INFO - TinderboxPrint: CPU usage
13.4% 04:01:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:01:13 INFO - TinderboxPrint: I/O write bytes / time
492,601,344 / 467,716 04:01:13 INFO - TinderboxPrint: CPU idle
8,204.3 (86.5%) 04:01:13 INFO - TinderboxPrint: CPU user
1,217.1 (12.8%) 04:01:13 INFO - TinderboxPrint: Swap in / out
0 / 0 04:01:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240971776; Read time: 0; Write time: 273724 04:01:13 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251629568; Read time: 20; Write time: 193992 04:01:13 INFO - Running post-run listener: _upload_blobber_files 04:01:13 INFO - Blob upload gear active. 04:01:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:01:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:01:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:01:14 INFO - (blobuploader) - INFO - Open directory for files ... 04:01:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:01:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:15 INFO - (blobuploader) - INFO - Done attempting. 04:01:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:01:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:15 INFO - (blobuploader) - INFO - Done attempting. 04:01:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:01:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:01:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:19 INFO - (blobuploader) - INFO - Done attempting. 04:01:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:01:19 INFO - Return code: 0 04:01:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:01:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:01:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8507189fc5e62ee1d0a8c5da3a0acf16e54f31682d68d44193b70ea7e439878bc200a037b071a026508a20a0ecf009661fbc483eab015244220ae5f7c69ef31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d06b97a2dcc9a639ccf0d1513598ac77cf4f39fd73576f2616d352191502dec2074a0f3968a444e710c222e3f173ac2c0585bcec8ae7692c1eee19d7e89dca18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71ecd3a4eedd347b37e38ce53d4344c59834351acae6b256f614d2578ff8d38c60ca66fff62764bf4be673d3d6c7dfc1c3dc522938e54e7ac88ebfe1e0c23c09"} 04:01:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:01:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:01:19 INFO - Contents: 04:01:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8507189fc5e62ee1d0a8c5da3a0acf16e54f31682d68d44193b70ea7e439878bc200a037b071a026508a20a0ecf009661fbc483eab015244220ae5f7c69ef31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d06b97a2dcc9a639ccf0d1513598ac77cf4f39fd73576f2616d352191502dec2074a0f3968a444e710c222e3f173ac2c0585bcec8ae7692c1eee19d7e89dca18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71ecd3a4eedd347b37e38ce53d4344c59834351acae6b256f614d2578ff8d38c60ca66fff62764bf4be673d3d6c7dfc1c3dc522938e54e7ac88ebfe1e0c23c09"} 04:01:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:01:19 INFO - Copying logs to upload dir... 04:01:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:01:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.335295 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-01 04:01:19.173358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 04:01:19.177326) ========= 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=c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672 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/b8507189fc5e62ee1d0a8c5da3a0acf16e54f31682d68d44193b70ea7e439878bc200a037b071a026508a20a0ecf009661fbc483eab015244220ae5f7c69ef31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d06b97a2dcc9a639ccf0d1513598ac77cf4f39fd73576f2616d352191502dec2074a0f3968a444e710c222e3f173ac2c0585bcec8ae7692c1eee19d7e89dca18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71ecd3a4eedd347b37e38ce53d4344c59834351acae6b256f614d2578ff8d38c60ca66fff62764bf4be673d3d6c7dfc1c3dc522938e54e7ac88ebfe1e0c23c09"} build_url:https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8507189fc5e62ee1d0a8c5da3a0acf16e54f31682d68d44193b70ea7e439878bc200a037b071a026508a20a0ecf009661fbc483eab015244220ae5f7c69ef31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d06b97a2dcc9a639ccf0d1513598ac77cf4f39fd73576f2616d352191502dec2074a0f3968a444e710c222e3f173ac2c0585bcec8ae7692c1eee19d7e89dca18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71ecd3a4eedd347b37e38ce53d4344c59834351acae6b256f614d2578ff8d38c60ca66fff62764bf4be673d3d6c7dfc1c3dc522938e54e7ac88ebfe1e0c23c09"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 04:01:19.205551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 04:01:19.206294) ========= 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=c6927cf182745ad25b1d38b9000001fe-1470046955.423415-897674672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004382 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 04:01:19.289504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 04:01:19.290286) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 04:01:19.290946) ========= ========= Total master_lag: 0.21 =========