builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1470044876.85 results: success (0) buildid: 20160731234823 builduid: ac593188bfc9435eb9125393ed1fd078 revision: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:56.851525) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:56.851987) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:56.852307) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:56.872625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:56.872933) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 02:47:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-08-01 02:47:57 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.067105 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:56.955298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:56.955636) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019793 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:57.006987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:57.007358) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 02:47:57,558 truncating revision to first 12 chars 2016-08-01 02:47:57,558 Setting DEBUG logging. 2016-08-01 02:47:57,558 attempt 1/10 2016-08-01 02:47:57,558 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 02:47:57,872 unpacking tar archive at: mozilla-aurora-fcdf4bb70356/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642668 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:57.665397) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:57.665719) ========= script_repo_revision: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:57.666158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:57.666488) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 02:47:57.676729) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-01 02:47:57.677053) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:47:58 INFO - MultiFileLogger online at 20160801 02:47:58 in /builds/slave/test 02:47:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:47:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:47:58 INFO - {'append_to_log': False, 02:47:58 INFO - 'base_work_dir': '/builds/slave/test', 02:47:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:47:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:47:58 INFO - 'branch': 'Mozilla-Aurora', 02:47:58 INFO - 'buildbot_json_path': 'buildprops.json', 02:47:58 INFO - 'config_files': ('talos/linux_config.py',), 02:47:58 INFO - 'default_actions': ('clobber', 02:47:58 INFO - 'read-buildbot-config', 02:47:58 INFO - 'download-and-extract', 02:47:58 INFO - 'populate-webroot', 02:47:58 INFO - 'create-virtualenv', 02:47:58 INFO - 'install', 02:47:58 INFO - 'run-tests'), 02:47:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:47:58 INFO - 'download_minidump_stackwalk': True, 02:47:58 INFO - 'download_symbols': 'ondemand', 02:47:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:47:58 INFO - 'tooltool.py': '/tools/tooltool.py', 02:47:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:47:58 INFO - '/tools/misc-python/virtualenv.py')}, 02:47:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:47:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:47:58 INFO - 'installer_path': 'installer.exe', 02:47:58 INFO - 'log_level': 'info', 02:47:58 INFO - 'log_name': 'talos', 02:47:58 INFO - 'log_to_console': True, 02:47:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:47:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:47:58 INFO - 'opt_config_files': (), 02:47:58 INFO - 'pip_index': False, 02:47:58 INFO - 'sps_profile': False, 02:47:58 INFO - 'sps_profile_interval': 0, 02:47:58 INFO - 'suite': 'dromaeojs-e10s', 02:47:58 INFO - 'system_bits': '32', 02:47:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:47:58 INFO - 'title': 'talos-linux64-ix-057', 02:47:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:47:58 INFO - 'use_talos_json': True, 02:47:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:47:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:47:58 INFO - 'work_dir': 'build'} 02:47:58 INFO - ##### 02:47:58 INFO - ##### Running clobber step. 02:47:58 INFO - ##### 02:47:58 INFO - Running pre-action listener: _resource_record_pre_action 02:47:58 INFO - Running main action method: clobber 02:47:58 INFO - rmtree: /builds/slave/test/build 02:47:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:47:58 INFO - Running post-action listener: _resource_record_post_action 02:47:58 INFO - ##### 02:47:58 INFO - ##### Finished clobber step (success) 02:47:58 INFO - ##### 02:47:58 INFO - ##### 02:47:58 INFO - ##### Running read-buildbot-config step. 02:47:58 INFO - ##### 02:47:58 INFO - Running pre-action listener: _resource_record_pre_action 02:47:58 INFO - Running main action method: read_buildbot_config 02:47:58 INFO - Using buildbot properties: 02:47:58 INFO - { 02:47:58 INFO - "project": "", 02:47:58 INFO - "product": "firefox", 02:47:58 INFO - "script_repo_revision": "production", 02:47:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:47:58 INFO - "repository": "", 02:47:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:47:58 INFO - "buildid": "20160731234823", 02:47:58 INFO - "pgo_build": "True", 02:47:58 INFO - "basedir": "/builds/slave/test", 02:47:58 INFO - "buildnumber": 486, 02:47:58 INFO - "slavename": "talos-linux64-ix-057", 02:47:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:47:58 INFO - "platform": "ubuntu64_hw", 02:47:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:47:58 INFO - "branch": "mozilla-aurora", 02:47:58 INFO - "repo_path": "releases/mozilla-aurora", 02:47:58 INFO - "revision": "fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff", 02:47:58 INFO - "stage_platform": "linux64-pgo", 02:47:58 INFO - "builduid": "ac593188bfc9435eb9125393ed1fd078", 02:47:58 INFO - "slavebuilddir": "test" 02:47:58 INFO - } 02:47:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 02:47:58 INFO - Running post-action listener: _resource_record_post_action 02:47:58 INFO - ##### 02:47:58 INFO - ##### Finished read-buildbot-config step (success) 02:47:58 INFO - ##### 02:47:58 INFO - ##### 02:47:58 INFO - ##### Running download-and-extract step. 02:47:58 INFO - ##### 02:47:58 INFO - Running pre-action listener: _resource_record_pre_action 02:47:58 INFO - Running main action method: download_and_extract 02:47:58 INFO - mkdir: /builds/slave/test/build/tests 02:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:58 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 02:47:58 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 02:47:58 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 02:47:58 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 02:47:58 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 02:48:01 INFO - Downloaded 1361 bytes. 02:48:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:48:01 INFO - Using the following test package requirements: 02:48:01 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:48:01 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:48:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:48:01 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:48:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:48:01 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:48:01 INFO - u'jsshell-linux-x86_64.zip'], 02:48:01 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:48:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:48:01 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:48:01 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:48:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:48:01 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:48:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:48:01 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:48:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:48:01 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:48:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:48:01 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:01 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 02:48:01 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 02:48:01 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 02:48:01 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 02:48:01 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 02:48:02 INFO - Downloaded 21967710 bytes. 02:48:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:48:03 INFO - Return code: 0 02:48:03 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:03 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 02:48:03 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 02:48:03 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 02:48:03 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 02:48:03 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 02:48:15 INFO - Downloaded 21967710 bytes. 02:48:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:48:16 INFO - Return code: 0 02:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:16 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 02:48:16 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 02:48:16 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 02:48:16 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 02:48:16 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 02:48:17 INFO - Downloaded 10833369 bytes. 02:48:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:48:17 INFO - Return code: 0 02:48: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')]} 02:48:17 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 02:48:17 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 02:48:17 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 02:48:17 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 02:48:17 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 02:48:20 INFO - Downloaded 61985118 bytes. 02:48:20 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 02:48:20 INFO - mkdir: /builds/slave/test/properties 02:48:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:20 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:20 INFO - Contents: 02:48:20 INFO - build_url:https://queue.taskcluster.net/v1/task/eLMM3hp0RVmJf3oSKD1zTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:48:20 INFO - Running post-action listener: _resource_record_post_action 02:48:20 INFO - Running post-action listener: set_extra_try_arguments 02:48:20 INFO - ##### 02:48:20 INFO - ##### Finished download-and-extract step (success) 02:48:20 INFO - ##### 02:48:20 INFO - ##### 02:48:20 INFO - ##### Running populate-webroot step. 02:48:20 INFO - ##### 02:48:20 INFO - Running pre-action listener: _resource_record_pre_action 02:48:20 INFO - Running main action method: populate_webroot 02:48:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:21 INFO - '--tppagecycles', 02:48:21 INFO - '7'], 02:48:21 INFO - 'tests': ['tsvgm']}}, 02:48:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:48:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:48:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:48:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:48:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:21 INFO - 'talos_options': ['--disable-e10s'], 02:48:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:21 INFO - 'talos_options': ['--disable-e10s'], 02:48:21 INFO - 'tests': ['damp', 'tps']}, 02:48:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:21 INFO - 'tests': ['damp', 'tps']}, 02:48:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:48:21 INFO - 'tests': ['dromaeo_dom']}, 02:48:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:48:21 INFO - 'tests': ['a11yr', 02:48:21 INFO - 'ts_paint', 02:48:21 INFO - 'tpaint', 02:48:21 INFO - 'sessionrestore', 02:48:21 INFO - 'sessionrestore_no_auto_restore', 02:48:21 INFO - 'tabpaint']}, 02:48:21 INFO - 'other-e10s': {'tests': ['a11yr', 02:48:21 INFO - 'ts_paint', 02:48:21 INFO - 'tpaint', 02:48:21 INFO - 'sessionrestore', 02:48:21 INFO - 'sessionrestore_no_auto_restore', 02:48:21 INFO - 'tabpaint']}, 02:48:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:48:21 INFO - 'ts_paint', 02:48:21 INFO - 'tpaint', 02:48:21 INFO - 'sessionrestore', 02:48:21 INFO - 'sessionrestore_no_auto_restore', 02:48:21 INFO - 'tabpaint']}, 02:48:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:48:21 INFO - 'ts_paint', 02:48:21 INFO - 'tpaint', 02:48:21 INFO - 'sessionrestore', 02:48:21 INFO - 'sessionrestore_no_auto_restore', 02:48:21 INFO - 'tabpaint']}, 02:48:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:48:21 INFO - 'tests': ['a11yr', 02:48:21 INFO - 'ts_paint', 02:48:21 INFO - 'tpaint', 02:48:21 INFO - 'sessionrestore', 02:48:21 INFO - 'sessionrestore_no_auto_restore', 02:48:21 INFO - 'tabpaint']}, 02:48:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:48:21 INFO - 'tests': ['a11yr', 02:48:21 INFO - 'ts_paint', 02:48:21 INFO - 'tpaint', 02:48:21 INFO - 'sessionrestore', 02:48:21 INFO - 'sessionrestore_no_auto_restore', 02:48:21 INFO - 'tabpaint']}, 02:48:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:48:21 INFO - 'tests': ['tsvgx', 02:48:21 INFO - 'tsvgr_opacity', 02:48:21 INFO - 'tart', 02:48:21 INFO - 'tscrollx', 02:48:21 INFO - 'cart']}, 02:48:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:48:21 INFO - 'tsvgr_opacity', 02:48:21 INFO - 'tart', 02:48:21 INFO - 'tscrollx', 02:48:21 INFO - 'cart']}, 02:48:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:21 INFO - 'talos_options': ['--disable-e10s'], 02:48:21 INFO - 'tests': ['tp5o']}, 02:48:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:21 INFO - 'tests': ['tp5o']}, 02:48:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:21 INFO - 'talos_options': ['--disable-e10s', 02:48:21 INFO - '--xperf_path', 02:48:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:21 INFO - 'tests': ['tp5n']}, 02:48:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:21 INFO - 'talos_options': ['--xperf_path', 02:48:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:21 INFO - 'tests': ['tp5n']}}, 02:48:21 INFO - 'talos.zip': {'path': '', 02:48:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:21 INFO - Running post-action listener: _resource_record_post_action 02:48:21 INFO - ##### 02:48:21 INFO - ##### Finished populate-webroot step (success) 02:48:21 INFO - ##### 02:48:21 INFO - ##### 02:48:21 INFO - ##### Running create-virtualenv step. 02:48:21 INFO - ##### 02:48:21 INFO - Running pre-action listener: _resource_record_pre_action 02:48:21 INFO - Running main action method: create_virtualenv 02:48:21 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:48:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:21 INFO - Using real prefix '/usr' 02:48:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:21 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:23 INFO - Installing pip.................done. 02:48:23 INFO - Return code: 0 02:48:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:23 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 0x7faa46b61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c36350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc51c0>, '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 0x1cc60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:48:23 INFO - Using env: {'DISPLAY': ':0', 02:48:23 INFO - 'HOME': '/home/cltbld', 02:48:23 INFO - 'LANG': 'en_US.UTF-8', 02:48:23 INFO - 'LANGUAGE': 'en_US:en', 02:48:23 INFO - 'LOGNAME': 'cltbld', 02:48:23 INFO - 'MAIL': '/var/mail/cltbld', 02:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:23 INFO - 'MOZ_NO_REMOTE': '1', 02:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:23 INFO - 'NO_EM_RESTART': '1', 02:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:23 INFO - 'PWD': '/builds/slave/test', 02:48:23 INFO - 'SHELL': '/bin/bash', 02:48:23 INFO - 'SHLVL': '1', 02:48:23 INFO - 'TERM': 'linux', 02:48:23 INFO - 'TMOUT': '86400', 02:48:23 INFO - 'USER': 'cltbld', 02:48:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 02:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:23 INFO - '_': '/tools/buildbot/bin/python'} 02:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:48:23 INFO - Cleaning up... 02:48:23 INFO - Return code: 0 02:48:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:23 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 0x7faa46b61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c36350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc51c0>, '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 0x1cc60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:48:23 INFO - Using env: {'DISPLAY': ':0', 02:48:23 INFO - 'HOME': '/home/cltbld', 02:48:23 INFO - 'LANG': 'en_US.UTF-8', 02:48:23 INFO - 'LANGUAGE': 'en_US:en', 02:48:23 INFO - 'LOGNAME': 'cltbld', 02:48:23 INFO - 'MAIL': '/var/mail/cltbld', 02:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:23 INFO - 'MOZ_NO_REMOTE': '1', 02:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:23 INFO - 'NO_EM_RESTART': '1', 02:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:23 INFO - 'PWD': '/builds/slave/test', 02:48:23 INFO - 'SHELL': '/bin/bash', 02:48:23 INFO - 'SHLVL': '1', 02:48:23 INFO - 'TERM': 'linux', 02:48:23 INFO - 'TMOUT': '86400', 02:48:23 INFO - 'USER': 'cltbld', 02:48:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 02:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:23 INFO - '_': '/tools/buildbot/bin/python'} 02:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:24 INFO - Downloading/unpacking psutil>=3.1.1 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:26 INFO - Installing collected packages: psutil 02:48:26 INFO - Running setup.py install for psutil 02:48:26 INFO - building 'psutil._psutil_linux' extension 02:48:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:48:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:48:26 INFO - building 'psutil._psutil_posix' extension 02:48:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:48:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:48:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:26 INFO - Successfully installed psutil 02:48:26 INFO - Cleaning up... 02:48:26 INFO - Return code: 0 02:48:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 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 0x7faa46b61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c36350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc51c0>, '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 0x1cc60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:48:26 INFO - Using env: {'DISPLAY': ':0', 02:48:26 INFO - 'HOME': '/home/cltbld', 02:48:26 INFO - 'LANG': 'en_US.UTF-8', 02:48:26 INFO - 'LANGUAGE': 'en_US:en', 02:48:26 INFO - 'LOGNAME': 'cltbld', 02:48:26 INFO - 'MAIL': '/var/mail/cltbld', 02:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:26 INFO - 'MOZ_NO_REMOTE': '1', 02:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:26 INFO - 'NO_EM_RESTART': '1', 02:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:26 INFO - 'PWD': '/builds/slave/test', 02:48:26 INFO - 'SHELL': '/bin/bash', 02:48:26 INFO - 'SHLVL': '1', 02:48:26 INFO - 'TERM': 'linux', 02:48:26 INFO - 'TMOUT': '86400', 02:48:26 INFO - 'USER': 'cltbld', 02:48:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 02:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:26 INFO - '_': '/tools/buildbot/bin/python'} 02:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:48:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:48:28 INFO - Installing collected packages: mozsystemmonitor 02:48:28 INFO - Running setup.py install for mozsystemmonitor 02:48:28 INFO - Successfully installed mozsystemmonitor 02:48:28 INFO - Cleaning up... 02:48:28 INFO - Return code: 0 02:48:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:28 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 0x7faa46b61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c36350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc51c0>, '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 0x1cc60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:48:28 INFO - Using env: {'DISPLAY': ':0', 02:48:28 INFO - 'HOME': '/home/cltbld', 02:48:28 INFO - 'LANG': 'en_US.UTF-8', 02:48:28 INFO - 'LANGUAGE': 'en_US:en', 02:48:28 INFO - 'LOGNAME': 'cltbld', 02:48:28 INFO - 'MAIL': '/var/mail/cltbld', 02:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:28 INFO - 'MOZ_NO_REMOTE': '1', 02:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:28 INFO - 'NO_EM_RESTART': '1', 02:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:28 INFO - 'PWD': '/builds/slave/test', 02:48:28 INFO - 'SHELL': '/bin/bash', 02:48:28 INFO - 'SHLVL': '1', 02:48:28 INFO - 'TERM': 'linux', 02:48:28 INFO - 'TMOUT': '86400', 02:48:28 INFO - 'USER': 'cltbld', 02:48:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 02:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:28 INFO - '_': '/tools/buildbot/bin/python'} 02:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:29 INFO - Downloading/unpacking jsonschema==2.5.1 02:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:31 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:31 INFO - warning: no files found matching '*.txt' 02:48:31 INFO - no previously-included directories found matching 'build' 02:48:31 INFO - no previously-included directories found matching 'dist' 02:48:31 INFO - no previously-included directories found matching '.git*' 02:48:31 INFO - Installing collected packages: jsonschema, functools32 02:48:31 INFO - Running setup.py install for functools32 02:48:31 INFO - warning: no files found matching '*.txt' 02:48:31 INFO - no previously-included directories found matching 'build' 02:48:31 INFO - no previously-included directories found matching 'dist' 02:48:31 INFO - no previously-included directories found matching '.git*' 02:48:31 INFO - Successfully installed jsonschema functools32 02:48:31 INFO - Cleaning up... 02:48:31 INFO - Return code: 0 02:48:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 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 0x7faa46b61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c36350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc51c0>, '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 0x1cc60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:48:31 INFO - Using env: {'DISPLAY': ':0', 02:48:31 INFO - 'HOME': '/home/cltbld', 02:48:31 INFO - 'LANG': 'en_US.UTF-8', 02:48:31 INFO - 'LANGUAGE': 'en_US:en', 02:48:31 INFO - 'LOGNAME': 'cltbld', 02:48:31 INFO - 'MAIL': '/var/mail/cltbld', 02:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:31 INFO - 'MOZ_NO_REMOTE': '1', 02:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:31 INFO - 'NO_EM_RESTART': '1', 02:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:31 INFO - 'PWD': '/builds/slave/test', 02:48:31 INFO - 'SHELL': '/bin/bash', 02:48:31 INFO - 'SHLVL': '1', 02:48:31 INFO - 'TERM': 'linux', 02:48:31 INFO - 'TMOUT': '86400', 02:48:31 INFO - 'USER': 'cltbld', 02:48:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 02:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:31 INFO - '_': '/tools/buildbot/bin/python'} 02:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:31 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:33 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:34 INFO - Downloading docopt-0.6.1.tar.gz 02:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:34 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:34 INFO - Running setup.py install for blobuploader 02:48:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:34 INFO - Running setup.py install for requests 02:48:34 INFO - Running setup.py install for docopt 02:48:35 INFO - Successfully installed blobuploader requests docopt 02:48:35 INFO - Cleaning up... 02:48:35 INFO - Return code: 0 02:48:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:35 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 0x7faa46b61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c36350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc51c0>, '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 0x1cc60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:35 INFO - Using env: {'DISPLAY': ':0', 02:48:35 INFO - 'HOME': '/home/cltbld', 02:48:35 INFO - 'LANG': 'en_US.UTF-8', 02:48:35 INFO - 'LANGUAGE': 'en_US:en', 02:48:35 INFO - 'LOGNAME': 'cltbld', 02:48:35 INFO - 'MAIL': '/var/mail/cltbld', 02:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:35 INFO - 'MOZ_NO_REMOTE': '1', 02:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:35 INFO - 'NO_EM_RESTART': '1', 02:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:35 INFO - 'PWD': '/builds/slave/test', 02:48:35 INFO - 'SHELL': '/bin/bash', 02:48:35 INFO - 'SHLVL': '1', 02:48:35 INFO - 'TERM': 'linux', 02:48:35 INFO - 'TMOUT': '86400', 02:48:35 INFO - 'USER': 'cltbld', 02:48:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 02:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:35 INFO - '_': '/tools/buildbot/bin/python'} 02:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:35 INFO - Running setup.py (path:/tmp/pip-mW0cXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:35 INFO - Running setup.py (path:/tmp/pip-PgVyI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:35 INFO - Running setup.py (path:/tmp/pip-LBHqVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:35 INFO - Running setup.py (path:/tmp/pip-FRk_Ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:35 INFO - Running setup.py (path:/tmp/pip-QJCnhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:35 INFO - Running setup.py (path:/tmp/pip-ZU9Fj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:35 INFO - Running setup.py (path:/tmp/pip-Mt8nQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:35 INFO - Running setup.py (path:/tmp/pip-Ybn4Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:35 INFO - Running setup.py (path:/tmp/pip-amMSDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:35 INFO - Running setup.py (path:/tmp/pip-TzkDFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:36 INFO - Running setup.py (path:/tmp/pip-fh8b78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:36 INFO - Running setup.py (path:/tmp/pip-6l4wGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:36 INFO - Running setup.py (path:/tmp/pip-dXAdMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:36 INFO - Running setup.py (path:/tmp/pip-cHK0bM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:36 INFO - Running setup.py (path:/tmp/pip-NDUOS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:36 INFO - Running setup.py (path:/tmp/pip-XdLVsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:36 INFO - Running setup.py (path:/tmp/pip-EXo3s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:36 INFO - Running setup.py install for manifestparser 02:48:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Running setup.py install for mozcrash 02:48:36 INFO - Running setup.py install for mozdebug 02:48:36 INFO - Running setup.py install for mozdevice 02:48:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Running setup.py install for mozfile 02:48:37 INFO - Running setup.py install for mozhttpd 02:48:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for mozinfo 02:48:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for mozInstall 02:48:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for mozleak 02:48:37 INFO - Running setup.py install for mozlog 02:48:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for moznetwork 02:48:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for mozprocess 02:48:37 INFO - Running setup.py install for mozprofile 02:48:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for mozrunner 02:48:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:38 INFO - Running setup.py install for mozscreenshot 02:48:38 INFO - Running setup.py install for moztest 02:48:38 INFO - Running setup.py install for mozversion 02:48:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:38 INFO - Cleaning up... 02:48:38 INFO - Return code: 0 02:48:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:38 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 0x7faa46b61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c36350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc51c0>, '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 0x1cc60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:38 INFO - Using env: {'DISPLAY': ':0', 02:48:38 INFO - 'HOME': '/home/cltbld', 02:48:38 INFO - 'LANG': 'en_US.UTF-8', 02:48:38 INFO - 'LANGUAGE': 'en_US:en', 02:48:38 INFO - 'LOGNAME': 'cltbld', 02:48:38 INFO - 'MAIL': '/var/mail/cltbld', 02:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:38 INFO - 'MOZ_NO_REMOTE': '1', 02:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:38 INFO - 'NO_EM_RESTART': '1', 02:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:38 INFO - 'PWD': '/builds/slave/test', 02:48:38 INFO - 'SHELL': '/bin/bash', 02:48:38 INFO - 'SHLVL': '1', 02:48:38 INFO - 'TERM': 'linux', 02:48:38 INFO - 'TMOUT': '86400', 02:48:38 INFO - 'USER': 'cltbld', 02:48:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 02:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:38 INFO - '_': '/tools/buildbot/bin/python'} 02:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:38 INFO - Running setup.py (path:/tmp/pip-s8WP5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:38 INFO - Running setup.py (path:/tmp/pip-JDv8iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:38 INFO - Running setup.py (path:/tmp/pip-n3GIJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:38 INFO - Running setup.py (path:/tmp/pip-rgm7Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:38 INFO - Running setup.py (path:/tmp/pip-TmTo61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:38 INFO - Running setup.py (path:/tmp/pip-5t5Fyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:39 INFO - Running setup.py (path:/tmp/pip-Pw5TLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:39 INFO - Running setup.py (path:/tmp/pip-nT2kWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:39 INFO - Running setup.py (path:/tmp/pip-mcF1s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:39 INFO - Running setup.py (path:/tmp/pip-jnwYKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:39 INFO - Running setup.py (path:/tmp/pip-Bip3Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:39 INFO - Running setup.py (path:/tmp/pip-95Bhsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:39 INFO - Running setup.py (path:/tmp/pip-NOQYMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:39 INFO - Running setup.py (path:/tmp/pip-rMWFu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:39 INFO - Running setup.py (path:/tmp/pip-8mYjI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:39 INFO - Running setup.py (path:/tmp/pip-P93QGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:39 INFO - Running setup.py (path:/tmp/pip-l2jOj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:41 INFO - Downloading blessings-1.6.tar.gz 02:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:41 INFO - Installing collected packages: blessings 02:48:41 INFO - Running setup.py install for blessings 02:48:41 INFO - Successfully installed blessings 02:48:41 INFO - Cleaning up... 02:48:41 INFO - Return code: 0 02:48:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:42 INFO - Reading from file tmpfile_stdout 02:48:42 INFO - Current package versions: 02:48:42 INFO - argparse == 1.2.1 02:48:42 INFO - blessings == 1.6 02:48:42 INFO - blobuploader == 1.2.4 02:48:42 INFO - docopt == 0.6.1 02:48:42 INFO - functools32 == 3.2.3-2 02:48:42 INFO - jsonschema == 2.5.1 02:48:42 INFO - manifestparser == 1.1 02:48:42 INFO - mozInstall == 1.12 02:48:42 INFO - mozcrash == 0.17 02:48:42 INFO - mozdebug == 0.1 02:48:42 INFO - mozdevice == 0.48 02:48:42 INFO - mozfile == 1.2 02:48:42 INFO - mozhttpd == 0.7 02:48:42 INFO - mozinfo == 0.9 02:48:42 INFO - mozleak == 0.1 02:48:42 INFO - mozlog == 3.2 02:48:42 INFO - moznetwork == 0.27 02:48:42 INFO - mozprocess == 0.23 02:48:42 INFO - mozprofile == 0.28 02:48:42 INFO - mozrunner == 6.12 02:48:42 INFO - mozscreenshot == 0.1 02:48:42 INFO - mozsystemmonitor == 0.3 02:48:42 INFO - moztest == 0.7 02:48:42 INFO - mozversion == 1.4 02:48:42 INFO - psutil == 3.1.1 02:48:42 INFO - requests == 1.2.3 02:48:42 INFO - wsgiref == 0.1.2 02:48:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:42 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 0x7faa46b61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c36350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc51c0>, '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 0x1cc60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:42 INFO - Using env: {'DISPLAY': ':0', 02:48:42 INFO - 'HOME': '/home/cltbld', 02:48:42 INFO - 'LANG': 'en_US.UTF-8', 02:48:42 INFO - 'LANGUAGE': 'en_US:en', 02:48:42 INFO - 'LOGNAME': 'cltbld', 02:48:42 INFO - 'MAIL': '/var/mail/cltbld', 02:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:42 INFO - 'MOZ_NO_REMOTE': '1', 02:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:42 INFO - 'NO_EM_RESTART': '1', 02:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:42 INFO - 'PWD': '/builds/slave/test', 02:48:42 INFO - 'SHELL': '/bin/bash', 02:48:42 INFO - 'SHLVL': '1', 02:48:42 INFO - 'TERM': 'linux', 02:48:42 INFO - 'TMOUT': '86400', 02:48:42 INFO - 'USER': 'cltbld', 02:48:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 02:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:42 INFO - '_': '/tools/buildbot/bin/python'} 02:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:48:42 INFO - Cleaning up... 02:48:42 INFO - Return code: 0 02:48:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:42 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 0x7faa46b61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c36350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc51c0>, '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 0x1cc60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:48:42 INFO - Using env: {'DISPLAY': ':0', 02:48:42 INFO - 'HOME': '/home/cltbld', 02:48:42 INFO - 'LANG': 'en_US.UTF-8', 02:48:42 INFO - 'LANGUAGE': 'en_US:en', 02:48:42 INFO - 'LOGNAME': 'cltbld', 02:48:42 INFO - 'MAIL': '/var/mail/cltbld', 02:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:42 INFO - 'MOZ_NO_REMOTE': '1', 02:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:42 INFO - 'NO_EM_RESTART': '1', 02:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:42 INFO - 'PWD': '/builds/slave/test', 02:48:42 INFO - 'SHELL': '/bin/bash', 02:48:42 INFO - 'SHLVL': '1', 02:48:42 INFO - 'TERM': 'linux', 02:48:42 INFO - 'TMOUT': '86400', 02:48:42 INFO - 'USER': 'cltbld', 02:48:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 02:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:42 INFO - '_': '/tools/buildbot/bin/python'} 02:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:48:42 INFO - Cleaning up... 02:48:42 INFO - Return code: 0 02:48:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:42 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 0x7faa46b61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c36350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc51c0>, '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 0x1cc60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:48:42 INFO - Using env: {'DISPLAY': ':0', 02:48:42 INFO - 'HOME': '/home/cltbld', 02:48:42 INFO - 'LANG': 'en_US.UTF-8', 02:48:42 INFO - 'LANGUAGE': 'en_US:en', 02:48:42 INFO - 'LOGNAME': 'cltbld', 02:48:42 INFO - 'MAIL': '/var/mail/cltbld', 02:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:42 INFO - 'MOZ_NO_REMOTE': '1', 02:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:42 INFO - 'NO_EM_RESTART': '1', 02:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:42 INFO - 'PWD': '/builds/slave/test', 02:48:42 INFO - 'SHELL': '/bin/bash', 02:48:42 INFO - 'SHLVL': '1', 02:48:42 INFO - 'TERM': 'linux', 02:48:42 INFO - 'TMOUT': '86400', 02:48:42 INFO - 'USER': 'cltbld', 02:48:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 02:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:42 INFO - '_': '/tools/buildbot/bin/python'} 02:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:42 INFO - Downloading/unpacking flake8 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:48:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:48:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:48:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:45 INFO - no previously-included directories found matching 'docs/_build' 02:48:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:48:45 INFO - Running setup.py install for pep8 02:48:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:45 INFO - no previously-included directories found matching 'docs/_build' 02:48:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:48:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:48:45 INFO - Cleaning up... 02:48:45 INFO - Return code: 0 02:48:45 INFO - Running post-action listener: _resource_record_post_action 02:48:45 INFO - Running post-action listener: _start_resource_monitoring 02:48:45 INFO - Starting resource monitoring. 02:48:45 INFO - ##### 02:48:45 INFO - ##### Finished create-virtualenv step (success) 02:48:45 INFO - ##### 02:48:45 INFO - ##### 02:48:45 INFO - ##### Running install step. 02:48:45 INFO - ##### 02:48:45 INFO - Running pre-action listener: _resource_record_pre_action 02:48:45 INFO - Running main action method: install 02:48:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:45 INFO - Reading from file tmpfile_stdout 02:48:45 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:45 INFO - Reading from file tmpfile_stdout 02:48:45 INFO - Output received: 02:48:45 INFO - Usage: mozinstall [options] installer 02:48:45 INFO - Options: 02:48:45 INFO - -h, --help show this help message and exit 02:48:45 INFO - -d DEST, --destination=DEST 02:48:45 INFO - Directory to install application into. [default: 02:48:45 INFO - "/builds/slave/test"] 02:48:45 INFO - --app=APP Application being installed. [default: firefox] 02:48:45 INFO - mkdir: /builds/slave/test/build/application 02:48:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:49:01 INFO - Reading from file tmpfile_stdout 02:49:01 INFO - Output received: 02:49:01 INFO - /builds/slave/test/build/application/firefox/firefox 02:49:01 INFO - Running post-action listener: _resource_record_post_action 02:49:01 INFO - ##### 02:49:01 INFO - ##### Finished install step (success) 02:49:01 INFO - ##### 02:49:01 INFO - ##### 02:49:01 INFO - ##### Running run-tests step. 02:49:01 INFO - ##### 02:49:01 INFO - Running pre-action listener: _resource_record_pre_action 02:49:01 INFO - Running main action method: run_tests 02:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:01 INFO - Python 2.7.3 02:49:01 INFO - Return code: 0 02:49:01 INFO - grabbing minidump binary from tooltool 02:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:01 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 0x1cc51c0>, '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 0x1cc60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:49:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:49:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:49:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:01 INFO - Return code: 0 02:49:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:49:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:49:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:49:02 INFO - Return code: 0 02:49:02 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-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:49:02 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-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:49:02 INFO - Using env: {'DISPLAY': ':0', 02:49:02 INFO - 'HOME': '/home/cltbld', 02:49:02 INFO - 'LANG': 'en_US.UTF-8', 02:49:02 INFO - 'LANGUAGE': 'en_US:en', 02:49:02 INFO - 'LOGNAME': 'cltbld', 02:49:02 INFO - 'MAIL': '/var/mail/cltbld', 02:49:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:02 INFO - 'MOZ_NO_REMOTE': '1', 02:49:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:02 INFO - 'NO_EM_RESTART': '1', 02:49:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:02 INFO - 'PWD': '/builds/slave/test', 02:49:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:02 INFO - 'SHELL': '/bin/bash', 02:49:02 INFO - 'SHLVL': '1', 02:49:02 INFO - 'TERM': 'linux', 02:49:02 INFO - 'TMOUT': '86400', 02:49:02 INFO - 'USER': 'cltbld', 02:49:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862', 02:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:02 INFO - '_': '/tools/buildbot/bin/python'} 02:49:02 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-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:49:02 INFO - mozversion application_buildid: 20160731234823 02:49:02 INFO - mozversion application_changeset: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff 02:49:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:49:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:02 INFO - mozversion application_name: Firefox 02:49:02 INFO - mozversion application_remotingname: firefox-dev 02:49:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:02 INFO - mozversion application_vendor: Mozilla 02:49:02 INFO - mozversion application_version: 49.0a2 02:49:02 INFO - mozversion platform_buildid: 20160731234823 02:49:02 INFO - mozversion platform_changeset: fcdf4bb703567bca5a5d7065f3a8a35ce1dea9ff 02:49:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:02 INFO - mozversion platform_version: 49.0a2 02:49:02 INFO - using testdate: 1470044942 02:49:02 INFO - actual date: 1470044942 02:49:02 INFO - starting webserver on 'localhost:36633' 02:49:02 INFO - SUITE-START | Running 2 tests 02:49:02 INFO - TEST-START | dromaeo_css 02:49:02 INFO - operating with platform_type : linux_ 02:49:02 INFO - Initialising browser for dromaeo_css test... 02:49:02 INFO - TEST-INFO | started process 29127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxiZuW6/profile http://localhost:36633/getInfo.html) 02:49:07 INFO - PROCESS | 29127 | __metrics Screen width/height:1600/1200 02:49:07 INFO - PROCESS | 29127 | colorDepth:24 02:49:07 INFO - PROCESS | 29127 | Browser inner width/height: 1024/697 02:49:07 INFO - PROCESS | 29127 | __metrics 02:49:08 ERROR - PROCESS | 29127 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:49:08 INFO - TEST-INFO | 29127: exit 0 02:49:08 INFO - Browser initialized. 02:49:08 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:08 INFO - TEST-INFO | started process 29255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxiZuW6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:20 INFO - PROCESS | 29255 | RSS: Main: 154030080 02:49:20 INFO - PROCESS | 29255 | 02:50:10 INFO - PROCESS | 29255 | 1470045010115 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:52:17 INFO - PROCESS | 29255 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36633/tests/dromaeo/cssquery-ext.html) 02:52:19 INFO - PROCESS | 29255 | RSS: Main: 158990336 02:52:19 INFO - PROCESS | 29255 | 02:55:21 INFO - PROCESS | 29255 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-ext.html (next: http://localhost:36633/tests/dromaeo/cssquery-jquery.html) 02:55:21 INFO - PROCESS | 29255 | RSS: Main: 156160000 02:55:21 INFO - PROCESS | 29255 | 02:58:23 INFO - PROCESS | 29255 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36633/tests/dromaeo/cssquery-mootools.html) 02:58:24 INFO - PROCESS | 29255 | RSS: Main: 155619328 02:58:24 INFO - PROCESS | 29255 | 03:01:25 INFO - PROCESS | 29255 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36633/tests/dromaeo/cssquery-prototype.html) 03:01:26 INFO - PROCESS | 29255 | RSS: Main: 155394048 03:01:26 INFO - PROCESS | 29255 | 03:04:28 INFO - PROCESS | 29255 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36633/tests/dromaeo/cssquery-yui.html) 03:04:29 INFO - PROCESS | 29255 | RSS: Main: 157556736 03:04:29 INFO - PROCESS | 29255 | 03:07:31 INFO - PROCESS | 29255 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-yui.html (next: http://localhost:36633/tests/dromaeo/cssquery-dojo.html) 03:07:32 INFO - PROCESS | 29255 | RSS: Main: 157585408 03:07:32 INFO - PROCESS | 29255 | 03:07:32 INFO - PROCESS | 29255 | __start_tp_report 03:07:32 INFO - PROCESS | 29255 | _x_x_mozilla_page_load 03:07:32 INFO - PROCESS | 29255 | _x_x_mozilla_page_load_details 03:07:32 INFO - PROCESS | 29255 | |i|pagename|runs| 03:07:32 INFO - PROCESS | 29255 | |0;dojo.html;3384.7799893006954;3418.145463634093;3425.126592718857;3438.6905178533925;3460.8615655373787;5632.521235694966;5666.688332141731;5669.8582535436635;5727.2268243787075;5737.340205876326;5688.288963879515;5704.372519022914;5725.456081672245;5743.396943320954;5760.7695692172265;5166;5210.192420174879;5211.687298762086;5250.474952504757;5270.077736396134;5122.795088196486;5176.948230517703;5206.817761378353;5252.3697156341295;5301.284326615896;5214.348206474191;5234.790608375661;5246.396664383587;5249.317588713462;5370.167624018283;5310.548603368718;5317.41508434072;5317.494837990384;5317.9468205317835;5343.251944727741;4957.727324997124;5082.644214904958;5213.687178769286;5223.2948551945765;5328.20076988451;5484.232207490954;5550.000999820031;5567.415421380778;5597.832065038056;5616;6008.369121242294;6064.332923378425;6101.511879049665;6129.816105516842;6143.955527560325;5970.701464926737;6080.513558915276;6121.051237058218;6192.566520343577;6194.039923811816;5704.857378565569;5707.086866101404;5708.086706127041;5715.114157305624;5718.399568045378;6284.5600807943;6304.022876454157;6317.9684101580115;6322.367763223733;6323.43089121972;5991.131285963511;6016.578839481194;6048.032314829607;6050.3949605040025;6085.2393450818645;6143.090142413939;6154.9384506154365;6178.320384757673;6179.721912513947;6183.81448556544;5983.431574000463;6144.754209831646;6151;6162.26052873649;6167.938320616826;6039.335673075958;6041.184440100618;6045.879082418327;6078.209832721806;6089.299730530957;4607.3319368691355;4675.579197872208;4680.836170734008;4683.484816670163;4706.893879938212;4079.530853951774;4112.958870411318;4184.748915065105;4186.644135248538;4212.136512015029;5776.191333213354;5786.797462088806;5841.4450627190345;5902.527797776168;5923.911141332884;6023.819285421357;6087.3303936566945;6096;6123.663198524124;6136.938630613726;5863.237779088691;5864.970675146597;5865;5875.588708790429;5886;5075.010372977234;5161.896762064737;5180.637355385163;5217.713025783618;5220.92168617471;6467.191601049869;6483.481321494363;6484.157059582224;6485.383888530582;6493.220813502316;6136.907946380718;6148.938510614837;6164.568480206342;6185.876282474415;6222.533310001859;6291.685415729104;6383.904241436475;6465.288818230085;6489.772857949949;6500.804975850732;6097.847553811191;6135.723892424762;6141.140240366263;6143.232095988002;6151.84620384494;6223;6245.156903817927;6245.156903817927;6259.3427690091885;6260.123582698517;5887.852803679943;5968.313643931004;5993.520518358608;6047.818565443044;6103.6032657877095;6009.429104235091;6045.365236650265;6051.788187413419;6061.636301821904;6061.848453788691;5671.17767923657;5965.045592705146;5982.0727787193055;5988.640681559121;6003.339632640494;6001.219841420762;6014.218151640259;6016.608920420334;6126.203593532812;6131.417515336036;5979.13302571116;5983.521318294613;5990.550708696952;6001.399860013964;6005.249343832021 03:07:32 INFO - PROCESS | 29255 | |1;ext.html;630.2814791138103;635.9395857393549;658.0688326018684;673.2157037051835;677.6781029011217;37610;39998;43257;43264.56735432645;43420.3486947696;43769.12461750763;44526.33210501845;44851.55148448514;45042.77478612611;45210.773946130306;8536.786580335494;8780.209781119698;8793;8798.648054077828;8818.382713210078;8610.956945215265;8688.609012594448;8734.257588105018;8734.475931444102;8741.650333986632;8735.912640873605;8776.69281575145;8779.95610021949;8797.208251257385;8831.425957312786;8727.912720872806;8764.079771623952;8772.69295574655;8783.516906570136;8809.779755506099;8594.828103437958;8660.17728315809;8732.825343493158;8739;8765.123487651184;36159.81920090409;40745.38881916774;41018.38472422916;41255;41333.379999300036;3312.354090952241;3314.734821214297;3486.3027394520946;3519.542459480251;3672.8163591820303;32662.97531886203;33062.50406243908;33339;33879;34268.14329641779;4356.281213599752;4546.340780586829;4565.954340456587;4587.357769912215;4657.068586282757;341118;345114;345428;345993;347879;38794;39132.60867391346;39325.80337098296;39469.40795888007;39511.40732889009;41940;42726;42965.57034429616;43009.784951075046;43143.568564314584;17841.375551855625;18025.63948721018;18053.458396248134;18073.27706891736;18148.092595370177;13530.526431574848;13601.795973060413;13604.115732477358;13616.591502254949;13628.250446225553;21370.679439808417;21419;21424;21653.458663533536;21656.133754649953;7441.367483763941;7600.707879660471;7631.771046868603;7730.536167829948;7937.682492700343;995.8207522645848;1137.5108703257513;1150.9827352589718;1174.8179032250016;1203.4945322964377;33303.00090997274;33618.663813361556;33632.49551256733;33711.66288337085;34100.1474963123;1163.3775929877645;1185.7865584194928;1249.6188662457855;1266.366816591704;1302.6547964789338;17318;17430.91284543569;17696.557586060193;17733.37933172333;17829.46511604654;644801;860634;870094;927430;939403;61818.69090654608;62321.37678623156;62391.064134038024;62403.37596624067;62719.372806271356;1418.8439271680106;1431.6850292935537;1443.9278036098153;1473.690524989764;1480.7719172204697;31652.5252121223;32175.51736723998;32568.34863302768;32990.17524561905;33051.504227436126;53041;53778;53812.73093634507;53989.460105398444;54060.459395405545;426955;427177;428008;428776;428915;30076.24809379783;30666.693333066385;30866.691333086383;30891.382172355978;31046;48645.756771215914;49797;49887.50112498829;50262.497375025785;50331.74834125806;40356.59643403528;41099.58900411077;41989.37015944702;42118.36822447604;42502.78748606237;40236.59763402446;40269.1946161081;41459.37810932778;41721.1655766889;42036;41168;42015.579844201166;42567.787161064;42664.78667606642;42968.78515607402;35926.28147437089;35994.46008309825;36509.951309487085;36747.63252367442;36839.63160368469;28545;28701.28246793847;31334.373312533167;31909.521357179197;31993.200169995936 03:07:32 INFO - PROCESS | 29255 | |2;jquery.html;407.4519770908128;424.30837734492775;425.9616634502894;432.3924885535822;433.0775448295129;18924.621507569842;20121.496962575926;20679.793202067976;21450.89274553625;21538.13847446104;13672.179669219853;17956.012419316932;18967.62064758704;19900.70148947767;19932.60134797303;5263.578913686905;5429.647072940266;5454;5457.672539647634;5497.092979658351;5325.174597937326;5405.486478784509;5835.328937172237;5877.970610146944;5918.1418694289305;5807.41925807418;5837.036888913324;5855.033919403293;5862.32583252925;5872.647641141524;5839.153322768196;6319.589226700273;6633.13769210002;6663.700133494004;6754.9662251688915;5875.618084824473;5982.940170598282;5991.970040149815;6028.7588496460085;6037.034074548052;14942.477013304482;15245.085294882232;20050.699239511418;23883.641745373832;24389;2186.7485239197536;2322.5935461294375;2342.121704360865;2383.4279772854566;2406.867622280774;10598.947005264925;10689.412082335468;10984.340939543654;11107.444627768578;13334.533291334757;1884.2274667386305;1943.7473128493205;1968.3897991622644;2107.3361891004283;2167.133146741316;70007;88131.67802482969;90252.54873725655;90485.09514904898;90915;11685.824712629317;11765.470553825098;12451.128421010624;12521.747825217406;12703.348564686716;14745.41018359275;17107.48677539676;17166;17229.91385043067;17269.913650431667;8146.877796833052;8407.369447291478;8413.411061225655;8739.30085593151;8749.956250218707;8185.181481851886;8194.22154895284;8230.176982301842;8282.958585207156;8341.749747507585;5138.3833939927445;5169.715665638426;5190.584753219733;5229.137192363293;5258.132408152612;2142.153849229546;2167.6640120781303;2174.423542931362;2191.101648324179;2199.3292045926146;968.4286271100085;984.9162821160138;1004.4626125023077;1036.3678156324636;1058.8517607534952;19155.425337239903;19743.210271588974;20022.199112035356;20129.09419076145;20259.493512662302;1054.4147997861107;1066.1044722433194;1072.6241375353472;1077.1275267033727;1077.4612693653173;10835.566577336976;11170.441477926071;11284.605038823602;11340.262882912584;11422.714432139097;527618;540175;544635;553822;554335;98062.50968745253;98065.50967245118;98302.50848745853;99324;100199;1071.2394200118003;1074.1245884604023;1083.0793825248634;1088.9455527223606;1100.471773548701;17667.823321766617;17708;17826;17929.193186306908;18050.638987219918;30826.845865770527;36188.09529761777;41200.793996031025;42164.367534486395;42926.78536607297;58303;58490.4150958485;58888.70555647366;59016.40983590281;60609.69695151496;8993.595288211915;9186.954065229631;9188.081191881025;9339.112784285482;9388.859167112361;10054.748631284276;10526.31578947366;13365.331733413484;13371.197728136343;13768.518101866386;11553.364564949008;11817.586384476503;11941.64175074749;12111.405756064098;12261.938690306848;11543.4805433754;11645.708857278298;11687.240329378563;11909.9882034971;11957.641270761891;11612.303261804318;11835.28988260707;12026.158168928441;12047.939760301142;12383.69040773988;9062.954685226532;9096.090390960851;9203.079692030744;9243.168114869693;9256.398334108262;10068.848967265643;11949.820752688544;11954.521819127138;11991.64025079249;12213.267203967791 03:07:32 INFO - PROCESS | 29255 | |3;mootools.html;1573.317493673287;1598.7362085255934;1796.6047469556693;1881.3227238194256;1929.2958070304344;8690.869636955435;9323.673671421502;9478.620855165786;9912.603495860176;9919.404835709853;9506.429614223134;9577.569009394576;9579.760505987353;9588.185004274628;9636.229101671866;2485.565026120431;2502.336880726609;2515.346010037385;2537.5939849624065;2538.4415428605676;2423.5516429460517;2426.7815896569305;2430.5260474207535;2435.062500937143;2438.9390265243333;2504.7745702886737;2506.6240063990367;2574.691037075544;2575.343287461704;2575.7295483974194;2473.628955656648;2487.3905893056226;2495.3262619092743;2503.086373473687;2509.736477669846;2439.1097249503982;2458.2748089313695;2461.5815311397105;2462.8152888533255;2469;9565.282603804673;9611.423314601147;9639.373440726331;9666;9703.272254580865;5597.384287728347;5650.29371328584;5670.092785154397;5704.600677952545;5728.828135155952;3631.891043268706;3708.8516459341595;3741.1021354874633;3742.4573436851774;3751.255666115242;1200.3518100225867;1279.9424025918856;1285.0554842190982;1289.3682095773097;1313.3695826003477;13714.65713357174;13751.656208594764;13757.10578812374;13854.515091971833;13901.58295251144;4940.357753492095;4997.475265097185;5122.334096567497;5148.253503242009;5163.690178589297;11372.578427696539;11403.201775875776;11437.542498299976;11455.083593312514;11558;5861.6189947653265;5862.14998825168;5893.6463812171405;5920.37836027211;5932.49573786233;4604.37840891482;5011.5489605935645;5244.659097158673;5269.578433725293;5360.303160589098;4312.525622181557;4330.978345108318;4336.067745434683;4398.846040388635;4403.163398954252;1357.2806412601337;1420.6732451536204;1421.1047040364504;1428.1573871415915;1429.463951018368;1017.1862509991977;1033.235405799703;1044.3733759744093;1061.6337363609543;1073.7959787640323;6332.525060620472;6502.44729198014;6575.112359831362;6633.900491492632;6638.7676431325635;482.49097202451753;493.7259820799419;1092.579356947581;1121.327203677803;1134.7900638381925;4590.517995610479;4630.438234360079;4659.44086709597;4697;4786.545278198566;11862.288262704265;12234.388280585936;12244.632661020183;12310.199837010565;12314.81527777084;11443.885561144449;11914.344711040803;11928.880711192776;12160.695982600506;12220.633380998584;8919.777005574782;9057.365984381162;9057.77355566116;9061.13919177677;9071.092890710876;6429.690803711388;6637.800865974028;6754.662266886734;6755.392014718699;6831.863362732817;10697.946510267398;11040.723981900517;11088.667339979813;11176.776464470828;11255.099592032782;11337.603183888525;11342.60300889465;11356.921092496199;11404.258723182966;11500.424978750862;7799.220077992155;8559.10129436425;8701.260392866678;8822.470651760916;9135.223506002065;9231.538423078953;9523.142917137491;9529.380590261611;9610.135087842127;9617.471039092638;8448.112948140602;8575.442596231225;8598.527081010605;8666.78333041679;8708.608112635073;8486.872696909428;8518.82962340762;8523.190296921783;8529.104444033288;8576.31389488827;7607.809804754926;7623.771286861403;7666.616669166631;7678.577678227751;7680.884786728316;5171.250168725589;5386.380566234777;5587.07813210832;5650;5719.999000175036;5687.345955215038;5729.885402291848;5739.196512488338;5806.274215723035;5822.679752613647 03:07:32 INFO - PROCESS | 29255 | |4;prototype.html;352.2637687233682;352.3024411664903;352.668491617879;353.9699125574325;356.86439153121825;5668.404817494165;5713;5717;5735.627184233027;5737.99999999999;5605.859853503654;5613.607047506676;5618.2415373924505;5620.241267428896;5623.437656234374;3995.4606128172613;4307.806148723315;4327.221100201962;4331.155424692186;4351.543087975764;4306.267934451151;4344.283193273106;4348.456442944632;4355.194289056519;4365.537544922439;4307.418498502709;4327.545607711177;4333.934990975122;4341.413909122275;4345.3047512398025;4232.555581663927;4297.290946993758;4304.806283717209;4314.137172565468;4316.525182229952;3790.3177428062936;3805.0677583991824;3807.60020197878;3810.6951443884423;3830.616938306175;5311.336082989626;5349.358077030781;5355.723817377599;5364.275822763916;5385.919211211796;4857.886819233645;4962.280469331963;4986.326845875833;4992.176290912032;5011.223260394645;5814.941850581482;5835.416458354173;5870.911936320958;5881.2942446906645;5916.4379383958885;4214.578542145791;4214.831406743757;4262;4266.381374700651;4271.572842715735;5966.134910437962;5997.43152824069;6000.549958753068;6015.428534289235;6073.4533891949495;4255.29787585045;4296.3125899856495;4325.805338759764;4339.500957389878;4344.304911214191;4328.458942632171;4370.890727731832;4380.890477738082;4381.539938306496;4401.735895846259;4699.95300047002;4940.827071052496;4970.279309500174;4971.1549036663855;4978.551930326288;5904.840910113069;5909.852253693606;5943.851403714942;5972.581919265696;6012.909806352908;1488.0699562773266;1492.417956996772;1493.133982290269;1501.4444655477325;1502.5867886331346;926.2775035472342;943.4103535542632;983.2723784399493;996.2478328861663;996.7209181429212;5789.421057894177;5820.76716931318;5825.912611310834;5834.649921004753;5849.88300233993;6018.187544681499;6030.216071910623;6069.787557435557;6073.301570319381;6085.269767627825;5585.748641311151;5670.68369167591;5774.960507108761;5778.162166485836;5794.30468343793;3175.412548678502;3213.5057198402856;3222.774405791572;3224.822634755111;3230.2570408806105;6173.783917562864;6280.796793635188;6310.968445157745;6322.36776322364;6369.9171140906155;6052.939470605325;6084;6109.84725381869;6138.600990935575;6153.661548614869;6096.3903609639565;6337.144485494491;6341.873162536724;6377.872442551123;6378.170837791057;5952.226210592596;5998.400159983967;6002.579819412599;6019;6046.244219472566;5874.706264686834;5925.496332811586;5974.2233509643465;5987.64074155552;6033.396660334107;6049.758009679739;6360.681965901594;6368.299487056327;6370.426661600478;6379.266384365857;4214.915701685888;4245.724027938298;4256.446661934053;4264.168487144977;4275.251830929513;5822.475977162076;5969.820905372846;5973.223480947449;6043.365446628217;6058.787942421994;5853.473187412983;5857.677827719516;5874.441928016831;5896.764129434775;5897.734601942837;5814.418558144321;5828.708564571839;5849.590528662953;5852.94147058541;5883.588148829541;5546.639468434539;5749.597528172988;5756.4457596449565;5872.265966754156;5882;5935.071101891816;6022.350165926978;6057.818265451867;6060.939390606038;6072.939270607238;5611.775528978795;5855.151003104611;5868.735906884286;5883.61756485827;5891.469767720926 03:07:32 INFO - PROCESS | 29255 | |5;yui.html;765.9808504787379;774.0169984120167;792.2354927494968;807.1766797866173;901.1529162587169;15733.134677592741;16425.917870410645;16682.082485463296;16729.74905376417;16810;15272;15451.613709657264;15755.212239388013;15788.289526971284;15793.526194214162;841.0958219913587;844.6874656377149;854.8076682746363;855.56366253211;873.9169778870997;860.535310932099;860.8880845490078;864.1617630898019;864.2653744317312;864.5158711121792;913.9497327646977;914.4513292024799;914.6752902719538;914.9679761208359;915.2997956563202;906.2749800159879;907.0340087806497;910.8952470465915;911.1617312072842;911.3757076402685;666.516775337881;668.4151367553391;671.2448495442627;671.5097978475691;671.6775947545157;15961.802864785072;16152.111633860133;16230.83769162305;16310.510684679479;16328.265228064647;14333.211673358066;14631;14634.41462341505;14713.485028023968;14761.409543618242;12975.221486710732;13039.152455090389;13059.54291599799;13121.540746073937;13212.933935330359;4014.116894283253;4065.6137666921595;4067.28822456069;4098.631123198927;4158.168366326717;82974;83055.5847220766;83475.58262208711;83782.16217837865;83953.16046839576;11885.16803823724;11951.88048119525;12069.094817888694;12384.690382740504;12446.751064978649;20268.290609828586;20330.79669203289;20548;20567.177312907315;20588.691169632468;9503.049695030442;9604.95197524008;9660.661876834278;9661.323707340418;9707.320487565943;4572.634189264851;4578.931316030262;4624.352590637313;4762;4792.832250871203;3760.2855457462992;3880;3891.630295121959;3897.649211570972;3898.493195884517;677.190757045336;695.1692727190958;705.108038331511;708.6988030087192;722.4473277942378;750.3359526818805;770.1874522378944;770.2567022823002;780.1067777394851;788.1440894156359;10679.305845120043;10801.945990270155;10970.396628185366;11106.777864442827;11112.55549778016;686.0669489494284;725.3834240895197;732.7765031665393;738.7045181927272;753.3972821742584;5000.299958005882;5150;5154.896902061938;5184.7407629618365;5210.010098081352;73739;85910;102028.48985755023;120946.3952680231;121883;71993.28006719971;76113;99041;101089.49455252677;102041.48979255205;91540.54229728809;93254;93503;93513.06486935043;93647.53176234211;9580.946095929581;9654.75863103428;9717.465539395402;9804.803903922024;9891.307608467627;53699.73150134224;53887;55213.44786552083;55544.6113847157;55822.162667560835;78187.00849402392;78384;80059.19940800518;80316.59841700754;81001.59499202466;13448.394822232827;13452.46190152383;13554.796678050034;13641.24973126448;13916.234607096707;14343.354549045527;14361.21013344276;14391.136531808124;14460.20468874222;14864.62838429048;13241.27173005494;13388.665283367995;13804.979335955566;13825.377857996615;14144.929275353557;13409.128406653535;13528.043087255899;13621.182729036289;13667.658308542366;13803.015135145803;13080.934595326962;14187.935904806975;14247.092863460879;14382;14890.181040042902;11554.653360398865;12044.21712588679;12350.320732359447;12392.289286624415;12700.428480718205;11702.824457632973;12206.6948326289;12267.938660306641;12272.631821045383;12650.683732906751 03:07:32 INFO - PROCESS | 29255 | __end_tp_report 03:07:32 INFO - PROCESS | 29255 | __start_cc_report 03:07:32 INFO - PROCESS | 29255 | _x_x_mozilla_cycle_collect,333 03:07:32 INFO - PROCESS | 29255 | __end_cc_report 03:07:32 INFO - PROCESS | 29255 | __startTimestamp1470046052008__endTimestamp 03:07:32 INFO - PROCESS | 29255 | 03:07:32 INFO - PROCESS | 29255 | ------- Summary: start ------- 03:07:32 INFO - PROCESS | 29255 | Number of tests: 6 03:07:32 INFO - PROCESS | 29255 | 03:07:32 INFO - PROCESS | 29255 | [#0] dojo.html Cycles:165 Average:5711.39 Median:5983.43 stddev:652.33 (10.9%) stddev-sans-first:628.27 03:07:32 INFO - PROCESS | 29255 | Values: 3384.8 3418.1 3425.1 3438.7 3460.9 5632.5 5666.7 5669.9 5727.2 5737.3 5688.3 5704.4 5725.5 5743.4 5760.8 5166.0 5210.2 5211.7 5250.5 5270.1 5122.8 5176.9 5206.8 5252.4 5301.3 5214.3 5234.8 5246.4 5249.3 5370.2 5310.5 5317.4 5317.5 5317.9 5343.3 4957.7 5082.6 5213.7 5223.3 5328.2 5484.2 5550.0 5567.4 5597.8 5616.0 6008.4 6064.3 6101.5 6129.8 6144.0 5970.7 6080.5 6121.1 6192.6 6194.0 5704.9 5707.1 5708.1 5715.1 5718.4 6284.6 6304.0 6318.0 6322.4 6323.4 5991.1 6016.6 6048.0 6050.4 6085.2 6143.1 6154.9 6178.3 6179.7 6183.8 5983.4 6144.8 6151.0 6162.3 6167.9 6039.3 6041.2 6045.9 6078.2 6089.3 4607.3 4675.6 4680.8 4683.5 4706.9 4079.5 4113.0 4184.7 4186.6 4212.1 5776.2 5786.8 5841.4 5902.5 5923.9 6023.8 6087.3 6096.0 6123.7 6136.9 5863.2 5865.0 5865.0 5875.6 5886.0 5075.0 5161.9 5180.6 5217.7 5220.9 6467.2 6483.5 6484.2 6485.4 6493.2 6136.9 6148.9 6164.6 6185.9 6222.5 6291.7 6383.9 6465.3 6489.8 6500.8 6097.8 6135.7 6141.1 6143.2 6151.8 6223.0 6245.2 6245.2 6259.3 6260.1 5887.9 5968.3 5993.5 6047.8 6103.6 6009.4 6045.4 6051.8 6061.6 6061.8 5671.2 5965.0 5982.1 5988.6 6003.3 6001.2 6014.2 6016.6 6126.2 6131.4 5979.1 5983.5 5990.6 6001.4 6005.2 03:07:32 INFO - PROCESS | 29255 | 03:07:32 INFO - PROCESS | 29255 | [#1] ext.html Cycles:180 Average:68125.45 Median:41396.38 stddev:158365.19 (382.6%) stddev-sans-first:158728.37 03:07:32 INFO - PROCESS | 29255 | Values: 630.3 635.9 658.1 673.2 677.7 37610.0 39998.0 43257.0 43264.6 43420.3 43769.1 44526.3 44851.6 45042.8 45210.8 8536.8 8780.2 8793.0 8798.6 8818.4 8611.0 8688.6 8734.3 8734.5 8741.7 8735.9 8776.7 8780.0 8797.2 8831.4 8727.9 8764.1 8772.7 8783.5 8809.8 8594.8 8660.2 8732.8 8739.0 8765.1 36159.8 40745.4 41018.4 41255.0 41333.4 3312.4 3314.7 3486.3 3519.5 3672.8 32663.0 33062.5 33339.0 33879.0 34268.1 4356.3 4546.3 4566.0 4587.4 4657.1 341118.0 345114.0 345428.0 345993.0 347879.0 38794.0 39132.6 39325.8 39469.4 39511.4 41940.0 42726.0 42965.6 43009.8 43143.6 17841.4 18025.6 18053.5 18073.3 18148.1 13530.5 13601.8 13604.1 13616.6 13628.3 21370.7 21419.0 21424.0 21653.5 21656.1 7441.4 7600.7 7631.8 7730.5 7937.7 995.8 1137.5 1151.0 1174.8 1203.5 33303.0 33618.7 33632.5 33711.7 34100.1 1163.4 1185.8 1249.6 1266.4 1302.7 17318.0 17430.9 17696.6 17733.4 17829.5 644801.0 860634.0 870094.0 927430.0 939403.0 61818.7 62321.4 62391.1 62403.4 62719.4 1418.8 1431.7 1443.9 1473.7 1480.8 31652.5 32175.5 32568.3 32990.2 33051.5 53041.0 53778.0 53812.7 53989.5 54060.5 426955.0 427177.0 428008.0 428776.0 428915.0 30076.2 30666.7 30866.7 30891.4 31046.0 48645.8 49797.0 49887.5 50262.5 50331.7 40356.6 41099.6 41989.4 42118.4 42502.8 40236.6 40269.2 41459.4 41721.2 42036.0 41168.0 42015.6 42567.8 42664.8 42968.8 35926.3 35994.5 36510.0 36747.6 36839.6 28545.0 28701.3 31334.4 31909.5 31993.2 03:07:32 INFO - PROCESS | 29255 | 03:07:32 INFO - PROCESS | 29255 | [#2] jquery.html Cycles:180 Average:30928.31 Median:2188.93 stddev:89651.69 (4095.7%) stddev-sans-first:89873.90 03:07:32 INFO - PROCESS | 29255 | Values: 407.5 424.3 426.0 432.4 433.1 18924.6 20121.5 20679.8 21450.9 21538.1 13672.2 17956.0 18967.6 19900.7 19932.6 5263.6 5429.6 5454.0 5457.7 5497.1 5325.2 5405.5 5835.3 5878.0 5918.1 5807.4 5837.0 5855.0 5862.3 5872.6 5839.2 6319.6 6633.1 6663.7 6755.0 5875.6 5982.9 5992.0 6028.8 6037.0 14942.5 15245.1 20050.7 23883.6 24389.0 2186.7 2322.6 2342.1 2383.4 2406.9 10598.9 10689.4 10984.3 11107.4 13334.5 1884.2 1943.7 1968.4 2107.3 2167.1 70007.0 88131.7 90252.5 90485.1 90915.0 11685.8 11765.5 12451.1 12521.7 12703.3 14745.4 17107.5 17166.0 17229.9 17269.9 8146.9 8407.4 8413.4 8739.3 8750.0 8185.2 8194.2 8230.2 8283.0 8341.7 5138.4 5169.7 5190.6 5229.1 5258.1 2142.2 2167.7 2174.4 2191.1 2199.3 968.4 984.9 1004.5 1036.4 1058.9 19155.4 19743.2 20022.2 20129.1 20259.5 1054.4 1066.1 1072.6 1077.1 1077.5 10835.6 11170.4 11284.6 11340.3 11422.7 527618.0 540175.0 544635.0 553822.0 554335.0 98062.5 98065.5 98302.5 99324.0 100199.0 1071.2 1074.1 1083.1 1088.9 1100.5 17667.8 17708.0 17826.0 17929.2 18050.6 30826.8 36188.1 41200.8 42164.4 42926.8 58303.0 58490.4 58888.7 59016.4 60609.7 8993.6 9187.0 9188.1 9339.1 9388.9 10054.7 10526.3 13365.3 13371.2 13768.5 11553.4 11817.6 11941.6 12111.4 12261.9 11543.5 11645.7 11687.2 11910.0 11957.6 11612.3 11835.3 12026.2 12047.9 12383.7 9063.0 9096.1 9203.1 9243.2 9256.4 10068.8 11949.8 11954.5 11991.6 12213.3 03:07:32 INFO - PROCESS | 29255 | 03:07:32 INFO - PROCESS | 29255 | [#3] mootools.html Cycles:180 Average:6393.41 Median:4644.94 stddev:3671.16 (79.0%) stddev-sans-first:3663.59 03:07:32 INFO - PROCESS | 29255 | Values: 1573.3 1598.7 1796.6 1881.3 1929.3 8690.9 9323.7 9478.6 9912.6 9919.4 9506.4 9577.6 9579.8 9588.2 9636.2 2485.6 2502.3 2515.3 2537.6 2538.4 2423.6 2426.8 2430.5 2435.1 2438.9 2504.8 2506.6 2574.7 2575.3 2575.7 2473.6 2487.4 2495.3 2503.1 2509.7 2439.1 2458.3 2461.6 2462.8 2469.0 9565.3 9611.4 9639.4 9666.0 9703.3 5597.4 5650.3 5670.1 5704.6 5728.8 3631.9 3708.9 3741.1 3742.5 3751.3 1200.4 1279.9 1285.1 1289.4 1313.4 13714.7 13751.7 13757.1 13854.5 13901.6 4940.4 4997.5 5122.3 5148.3 5163.7 11372.6 11403.2 11437.5 11455.1 11558.0 5861.6 5862.1 5893.6 5920.4 5932.5 4604.4 5011.5 5244.7 5269.6 5360.3 4312.5 4331.0 4336.1 4398.8 4403.2 1357.3 1420.7 1421.1 1428.2 1429.5 1017.2 1033.2 1044.4 1061.6 1073.8 6332.5 6502.4 6575.1 6633.9 6638.8 482.5 493.7 1092.6 1121.3 1134.8 4590.5 4630.4 4659.4 4697.0 4786.5 11862.3 12234.4 12244.6 12310.2 12314.8 11443.9 11914.3 11928.9 12160.7 12220.6 8919.8 9057.4 9057.8 9061.1 9071.1 6429.7 6637.8 6754.7 6755.4 6831.9 10697.9 11040.7 11088.7 11176.8 11255.1 11337.6 11342.6 11356.9 11404.3 11500.4 7799.2 8559.1 8701.3 8822.5 9135.2 9231.5 9523.1 9529.4 9610.1 9617.5 8448.1 8575.4 8598.5 8666.8 8708.6 8486.9 8518.8 8523.2 8529.1 8576.3 7607.8 7623.8 7666.6 7678.6 7680.9 5171.3 5386.4 5587.1 5650.0 5720.0 5687.3 5729.9 5739.2 5806.3 5822.7 03:07:32 INFO - PROCESS | 29255 | 03:07:32 INFO - PROCESS | 29255 | [#4] prototype.html Cycles:180 Average:4958.83 Median:5765.70 stddev:1473.17 (25.6%) stddev-sans-first:1436.15 03:07:32 INFO - PROCESS | 29255 | Values: 352.3 352.3 352.7 354.0 356.9 5668.4 5713.0 5717.0 5735.6 5738.0 5605.9 5613.6 5618.2 5620.2 5623.4 3995.5 4307.8 4327.2 4331.2 4351.5 4306.3 4344.3 4348.5 4355.2 4365.5 4307.4 4327.5 4333.9 4341.4 4345.3 4232.6 4297.3 4304.8 4314.1 4316.5 3790.3 3805.1 3807.6 3810.7 3830.6 5311.3 5349.4 5355.7 5364.3 5385.9 4857.9 4962.3 4986.3 4992.2 5011.2 5814.9 5835.4 5870.9 5881.3 5916.4 4214.6 4214.8 4262.0 4266.4 4271.6 5966.1 5997.4 6000.5 6015.4 6073.5 4255.3 4296.3 4325.8 4339.5 4344.3 4328.5 4370.9 4380.9 4381.5 4401.7 4700.0 4940.8 4970.3 4971.2 4978.6 5904.8 5909.9 5943.9 5972.6 6012.9 1488.1 1492.4 1493.1 1501.4 1502.6 926.3 943.4 983.3 996.2 996.7 5789.4 5820.8 5825.9 5834.6 5849.9 6018.2 6030.2 6069.8 6073.3 6085.3 5585.7 5670.7 5775.0 5778.2 5794.3 3175.4 3213.5 3222.8 3224.8 3230.3 6173.8 6280.8 6311.0 6322.4 6369.9 6052.9 6084.0 6109.8 6138.6 6153.7 6096.4 6337.1 6341.9 6377.9 6378.2 5952.2 5998.4 6002.6 6019.0 6046.2 5874.7 5925.5 5974.2 5987.6 6033.4 6049.8 6360.7 6368.3 6370.4 6379.3 4214.9 4245.7 4256.4 4264.2 4275.3 5822.5 5969.8 5973.2 6043.4 6058.8 5853.5 5857.7 5874.4 5896.8 5897.7 5814.4 5828.7 5849.6 5852.9 5883.6 5546.6 5749.6 5756.4 5872.3 5882.0 5935.1 6022.4 6057.8 6060.9 6072.9 5611.8 5855.2 5868.7 5883.6 5891.5 03:07:32 INFO - PROCESS | 29255 | 03:07:32 INFO - PROCESS | 29255 | [#5] yui.html Cycles:180 Average:21103.69 Median:4575.78 stddev:29499.64 (644.7%) stddev-sans-first:29542.87 03:07:32 INFO - PROCESS | 29255 | Values: 766.0 774.0 792.2 807.2 901.2 15733.1 16425.9 16682.1 16729.7 16810.0 15272.0 15451.6 15755.2 15788.3 15793.5 841.1 844.7 854.8 855.6 873.9 860.5 860.9 864.2 864.3 864.5 913.9 914.5 914.7 915.0 915.3 906.3 907.0 910.9 911.2 911.4 666.5 668.4 671.2 671.5 671.7 15961.8 16152.1 16230.8 16310.5 16328.3 14333.2 14631.0 14634.4 14713.5 14761.4 12975.2 13039.2 13059.5 13121.5 13212.9 4014.1 4065.6 4067.3 4098.6 4158.2 82974.0 83055.6 83475.6 83782.2 83953.2 11885.2 11951.9 12069.1 12384.7 12446.8 20268.3 20330.8 20548.0 20567.2 20588.7 9503.0 9605.0 9660.7 9661.3 9707.3 4572.6 4578.9 4624.4 4762.0 4792.8 3760.3 3880.0 3891.6 3897.6 3898.5 677.2 695.2 705.1 708.7 722.4 750.3 770.2 770.3 780.1 788.1 10679.3 10801.9 10970.4 11106.8 11112.6 686.1 725.4 732.8 738.7 753.4 5000.3 5150.0 5154.9 5184.7 5210.0 73739.0 85910.0 102028.5 120946.4 121883.0 71993.3 76113.0 99041.0 101089.5 102041.5 91540.5 93254.0 93503.0 93513.1 93647.5 9580.9 9654.8 9717.5 9804.8 9891.3 53699.7 53887.0 55213.4 55544.6 55822.2 78187.0 78384.0 80059.2 80316.6 81001.6 13448.4 13452.5 13554.8 13641.2 13916.2 14343.4 14361.2 14391.1 14460.2 14864.6 13241.3 13388.7 13805.0 13825.4 14144.9 13409.1 13528.0 13621.2 13667.7 13803.0 13080.9 14187.9 14247.1 14382.0 14890.2 11554.7 12044.2 12350.3 12392.3 12700.4 11702.8 12206.7 12267.9 12272.6 12650.7 03:07:32 INFO - PROCESS | 29255 | -------- Summary: end -------- 03:07:32 INFO - PROCESS | 29255 | 03:07:32 INFO - TEST-INFO | 29255: exit 0 03:07:32 INFO - TEST-OK | dromaeo_css | took 1109978ms 03:07:32 INFO - TEST-START | kraken 03:07:32 INFO - operating with platform_type : linux_ 03:07:32 INFO - Initialising browser for kraken test... 03:07:32 INFO - TEST-INFO | started process 29491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0d7rUI/profile http://localhost:36633/getInfo.html) 03:07:37 INFO - PROCESS | 29491 | __metrics Screen width/height:1600/1200 03:07:37 INFO - PROCESS | 29491 | colorDepth:24 03:07:37 INFO - PROCESS | 29491 | Browser inner width/height: 1024/697 03:07:37 INFO - PROCESS | 29491 | __metrics 03:07:38 ERROR - PROCESS | 29491 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 03:07:39 INFO - TEST-INFO | 29491: exit 0 03:07:39 INFO - Browser initialized. 03:07:39 INFO - Running cycle 1/1 for kraken test... 03:07:39 INFO - TEST-INFO | started process 29623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0d7rUI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:07:50 INFO - PROCESS | 29623 | RSS: Main: 153927680 03:07:50 INFO - PROCESS | 29623 | 03:07:53 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36633/tests/kraken/driver.html?testName=audio-beat-detection) 03:07:54 INFO - PROCESS | 29623 | RSS: Main: 158294016 03:07:54 INFO - PROCESS | 29623 | 03:07:56 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36633/tests/kraken/driver.html?testName=audio-dft) 03:07:57 INFO - PROCESS | 29623 | RSS: Main: 157990912 03:07:57 INFO - PROCESS | 29623 | 03:08:00 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36633/tests/kraken/driver.html?testName=audio-fft) 03:08:00 INFO - PROCESS | 29623 | RSS: Main: 159141888 03:08:00 INFO - PROCESS | 29623 | 03:08:03 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36633/tests/kraken/driver.html?testName=audio-oscillator) 03:08:03 INFO - PROCESS | 29623 | RSS: Main: 158875648 03:08:03 INFO - PROCESS | 29623 | 03:08:05 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36633/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:06 INFO - PROCESS | 29623 | RSS: Main: 158547968 03:08:06 INFO - PROCESS | 29623 | 03:08:09 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36633/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:10 INFO - PROCESS | 29623 | RSS: Main: 158343168 03:08:10 INFO - PROCESS | 29623 | 03:08:13 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36633/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:14 INFO - PROCESS | 29623 | RSS: Main: 158515200 03:08:14 INFO - PROCESS | 29623 | 03:08:17 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36633/tests/kraken/driver.html?testName=json-parse-financial) 03:08:17 INFO - PROCESS | 29623 | RSS: Main: 158928896 03:08:17 INFO - PROCESS | 29623 | 03:08:19 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36633/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:19 INFO - PROCESS | 29623 | RSS: Main: 158507008 03:08:19 INFO - PROCESS | 29623 | 03:08:21 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:22 INFO - PROCESS | 29623 | RSS: Main: 158412800 03:08:22 INFO - PROCESS | 29623 | 03:08:24 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:24 INFO - PROCESS | 29623 | RSS: Main: 159150080 03:08:24 INFO - PROCESS | 29623 | 03:08:27 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:08:28 INFO - PROCESS | 29623 | RSS: Main: 159223808 03:08:28 INFO - PROCESS | 29623 | 03:08:30 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:08:31 INFO - PROCESS | 29623 | RSS: Main: 159031296 03:08:31 INFO - PROCESS | 29623 | 03:08:32 INFO - PROCESS | 29623 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36633/tests/kraken/driver.html?testName=ai-astar) 03:08:33 INFO - PROCESS | 29623 | RSS: Main: 159805440 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | __start_tp_report 03:08:33 INFO - PROCESS | 29623 | _x_x_mozilla_page_load 03:08:33 INFO - PROCESS | 29623 | _x_x_mozilla_page_load_details 03:08:33 INFO - PROCESS | 29623 | |i|pagename|runs| 03:08:33 INFO - PROCESS | 29623 | |0;ai-astar;110;118;110;111;110;112;110;111;111;110 03:08:33 INFO - PROCESS | 29623 | |1;audio-beat-detection;163;123;156;179;128;155;154;126;186;127 03:08:33 INFO - PROCESS | 29623 | |2;audio-dft;163;162;163;161;162;161;162;161;161;165 03:08:33 INFO - PROCESS | 29623 | |3;audio-fft;75;76;76;167;75;77;75;75;182;75 03:08:33 INFO - PROCESS | 29623 | |4;audio-oscillator;86;85;143;85;84;85;132;84;84;140 03:08:33 INFO - PROCESS | 29623 | |5;imaging-gaussian-blur;118;117;117;117;118;118;118;118;118;118 03:08:33 INFO - PROCESS | 29623 | |6;imaging-darkroom;146;148;148;146;148;148;148;148;147;146 03:08:33 INFO - PROCESS | 29623 | |7;imaging-desaturate;95;97;98;95;95;96;95;96;95;94 03:08:33 INFO - PROCESS | 29623 | |8;json-parse-financial;52;51;55;52;56;54;58;54;53;56 03:08:33 INFO - PROCESS | 29623 | |9;json-stringify-tinderbox;62;61;61;61;61;60;61;64;60;60 03:08:33 INFO - PROCESS | 29623 | |10;stanford-crypto-aes;76;77;76;75;78;78;78;77;106;77 03:08:33 INFO - PROCESS | 29623 | |11;stanford-crypto-ccm;133;128;126;116;117;116;121;120;130;121 03:08:33 INFO - PROCESS | 29623 | |12;stanford-crypto-pbkdf2;155;157;157;152;158;151;157;150;152;154 03:08:33 INFO - PROCESS | 29623 | |13;stanford-crypto-sha256-iterative;66;62;63;62;62;62;60;61;60;60 03:08:33 INFO - PROCESS | 29623 | __end_tp_report 03:08:33 INFO - PROCESS | 29623 | __start_cc_report 03:08:33 INFO - PROCESS | 29623 | _x_x_mozilla_cycle_collect,893 03:08:33 INFO - PROCESS | 29623 | __end_cc_report 03:08:33 INFO - PROCESS | 29623 | __startTimestamp1470046113154__endTimestamp 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | ------- Summary: start ------- 03:08:33 INFO - PROCESS | 29623 | Number of tests: 14 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:2.45 (2.2%) stddev-sans-first:2.55 03:08:33 INFO - PROCESS | 29623 | Values: 110.0 118.0 110.0 111.0 110.0 112.0 110.0 111.0 111.0 110.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:155.50 stddev:22.85 (14.7%) stddev-sans-first:23.73 03:08:33 INFO - PROCESS | 29623 | Values: 163.0 123.0 156.0 179.0 128.0 155.0 154.0 126.0 186.0 127.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 03:08:33 INFO - PROCESS | 29623 | Values: 163.0 162.0 163.0 161.0 162.0 161.0 162.0 161.0 161.0 165.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.00 stddev:41.90 (55.9%) stddev-sans-first:43.79 03:08:33 INFO - PROCESS | 29623 | Values: 75.0 76.0 76.0 167.0 75.0 77.0 75.0 75.0 182.0 75.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:84.50 stddev:26.05 (30.8%) stddev-sans-first:27.07 03:08:33 INFO - PROCESS | 29623 | Values: 86.0 85.0 143.0 85.0 84.0 85.0 132.0 84.0 84.0 140.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:08:33 INFO - PROCESS | 29623 | Values: 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 03:08:33 INFO - PROCESS | 29623 | Values: 146.0 148.0 148.0 146.0 148.0 148.0 148.0 148.0 147.0 146.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:1.17 (1.2%) stddev-sans-first:1.22 03:08:33 INFO - PROCESS | 29623 | Values: 95.0 97.0 98.0 95.0 95.0 96.0 95.0 96.0 95.0 94.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:2.18 (4.0%) stddev-sans-first:2.18 03:08:33 INFO - PROCESS | 29623 | Values: 52.0 51.0 55.0 52.0 56.0 54.0 58.0 54.0 53.0 56.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:1.20 (2.0%) stddev-sans-first:1.22 03:08:33 INFO - PROCESS | 29623 | Values: 62.0 61.0 61.0 61.0 61.0 60.0 61.0 64.0 60.0 60.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:77.00 stddev:9.26 (12.0%) stddev-sans-first:9.72 03:08:33 INFO - PROCESS | 29623 | Values: 76.0 77.0 76.0 75.0 78.0 78.0 78.0 77.0 106.0 77.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:123.50 stddev:6.09 (4.9%) stddev-sans-first:5.22 03:08:33 INFO - PROCESS | 29623 | Values: 133.0 128.0 126.0 116.0 117.0 116.0 121.0 120.0 130.0 121.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:156.00 stddev:2.91 (1.9%) stddev-sans-first:3.07 03:08:33 INFO - PROCESS | 29623 | Values: 155.0 157.0 157.0 152.0 158.0 151.0 157.0 150.0 152.0 154.0 03:08:33 INFO - PROCESS | 29623 | 03:08:33 INFO - PROCESS | 29623 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.81 (2.9%) stddev-sans-first:1.12 03:08:33 INFO - PROCESS | 29623 | Values: 66.0 62.0 63.0 62.0 62.0 62.0 60.0 61.0 60.0 60.0 03:08:33 INFO - PROCESS | 29623 | -------- Summary: end -------- 03:08:33 INFO - PROCESS | 29623 | 03:08:34 INFO - TEST-INFO | 29623: exit 0 03:08:34 INFO - TEST-OK | kraken | took 61356ms 03:08:34 INFO - SUITE-END | took 1171s 03:08:34 INFO - Completed test suite (00:19:31) 03:08:34 INFO - javascript benchmark 03:08:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7653.305863855084, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3384.7799893006954, 3418.145463634093, 3425.126592718857, 3438.6905178533925, 3460.8615655373787, 5632.521235694966, 5666.688332141731, 5669.8582535436635, 5727.2268243787075, 5737.340205876326, 5688.288963879515, 5704.372519022914, 5725.456081672245, 5743.396943320954, 5760.7695692172265, 5166.0, 5210.192420174879, 5211.687298762086, 5250.474952504757, 5270.077736396134, 5122.795088196486, 5176.948230517703, 5206.817761378353, 5252.3697156341295, 5301.284326615896, 5214.348206474191, 5234.790608375661, 5246.396664383587, 5249.317588713462, 5370.167624018283, 5310.548603368718, 5317.41508434072, 5317.494837990384, 5317.9468205317835, 5343.251944727741, 4957.727324997124, 5082.644214904958, 5213.687178769286, 5223.2948551945765, 5328.20076988451, 5484.232207490954, 5550.000999820031, 5567.415421380778, 5597.832065038056, 5616.0, 6008.369121242294, 6064.332923378425, 6101.511879049665, 6129.816105516842, 6143.955527560325, 5970.701464926737, 6080.513558915276, 6121.051237058218, 6192.566520343577, 6194.039923811816, 5704.857378565569, 5707.086866101404, 5708.086706127041, 5715.114157305624, 5718.399568045378, 6284.5600807943, 6304.022876454157, 6317.9684101580115, 6322.367763223733, 6323.43089121972, 5991.131285963511, 6016.578839481194, 6048.032314829607, 6050.3949605040025, 6085.2393450818645, 6143.090142413939, 6154.9384506154365, 6178.320384757673, 6179.721912513947, 6183.81448556544, 5983.431574000463, 6144.754209831646, 6151.0, 6162.26052873649, 6167.938320616826, 6039.335673075958, 6041.184440100618, 6045.879082418327, 6078.209832721806, 6089.299730530957, 4607.3319368691355, 4675.579197872208, 4680.836170734008, 4683.484816670163, 4706.893879938212, 4079.530853951774, 4112.958870411318, 4184.748915065105, 4186.644135248538, 4212.136512015029, 5776.191333213354, 5786.797462088806, 5841.4450627190345, 5902.527797776168, 5923.911141332884, 6023.819285421357, 6087.3303936566945, 6096.0, 6123.663198524124, 6136.938630613726, 5863.237779088691, 5864.970675146597, 5865.0, 5875.588708790429, 5886.0, 5075.010372977234, 5161.896762064737, 5180.637355385163, 5217.713025783618, 5220.92168617471, 6467.191601049869, 6483.481321494363, 6484.157059582224, 6485.383888530582, 6493.220813502316, 6136.907946380718, 6148.938510614837, 6164.568480206342, 6185.876282474415, 6222.533310001859, 6291.685415729104, 6383.904241436475, 6465.288818230085, 6489.772857949949, 6500.804975850732, 6097.847553811191, 6135.723892424762, 6141.140240366263, 6143.232095988002, 6151.84620384494, 6223.0, 6245.156903817927, 6245.156903817927, 6259.3427690091885, 6260.123582698517, 5887.852803679943, 5968.313643931004, 5993.520518358608, 6047.818565443044, 6103.6032657877095, 6009.429104235091, 6045.365236650265, 6051.788187413419, 6061.636301821904, 6061.848453788691, 5671.17767923657, 5965.045592705146, 5982.0727787193055, 5988.640681559121, 6003.339632640494, 6001.219841420762, 6014.218151640259, 6016.608920420334, 6126.203593532812, 6131.417515336036, 5979.13302571116, 5983.521318294613, 5990.550708696952, 6001.399860013964, 6005.249343832021], "value": 5667.868936971954, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.2814791138103, 635.9395857393549, 658.0688326018684, 673.2157037051835, 677.6781029011217, 37610.0, 39998.0, 43257.0, 43264.56735432645, 43420.3486947696, 43769.12461750763, 44526.33210501845, 44851.55148448514, 45042.77478612611, 45210.773946130306, 8536.786580335494, 8780.209781119698, 8793.0, 8798.648054077828, 8818.382713210078, 8610.956945215265, 8688.609012594448, 8734.257588105018, 8734.475931444102, 8741.650333986632, 8735.912640873605, 8776.69281575145, 8779.95610021949, 8797.208251257385, 8831.425957312786, 8727.912720872806, 8764.079771623952, 8772.69295574655, 8783.516906570136, 8809.779755506099, 8594.828103437958, 8660.17728315809, 8732.825343493158, 8739.0, 8765.123487651184, 36159.81920090409, 40745.38881916774, 41018.38472422916, 41255.0, 41333.379999300036, 3312.354090952241, 3314.734821214297, 3486.3027394520946, 3519.542459480251, 3672.8163591820303, 32662.97531886203, 33062.50406243908, 33339.0, 33879.0, 34268.14329641779, 4356.281213599752, 4546.340780586829, 4565.954340456587, 4587.357769912215, 4657.068586282757, 341118.0, 345114.0, 345428.0, 345993.0, 347879.0, 38794.0, 39132.60867391346, 39325.80337098296, 39469.40795888007, 39511.40732889009, 41940.0, 42726.0, 42965.57034429616, 43009.784951075046, 43143.568564314584, 17841.375551855625, 18025.63948721018, 18053.458396248134, 18073.27706891736, 18148.092595370177, 13530.526431574848, 13601.795973060413, 13604.115732477358, 13616.591502254949, 13628.250446225553, 21370.679439808417, 21419.0, 21424.0, 21653.458663533536, 21656.133754649953, 7441.367483763941, 7600.707879660471, 7631.771046868603, 7730.536167829948, 7937.682492700343, 995.8207522645848, 1137.5108703257513, 1150.9827352589718, 1174.8179032250016, 1203.4945322964377, 33303.00090997274, 33618.663813361556, 33632.49551256733, 33711.66288337085, 34100.1474963123, 1163.3775929877645, 1185.7865584194928, 1249.6188662457855, 1266.366816591704, 1302.6547964789338, 17318.0, 17430.91284543569, 17696.557586060193, 17733.37933172333, 17829.46511604654, 644801.0, 860634.0, 870094.0, 927430.0, 939403.0, 61818.69090654608, 62321.37678623156, 62391.064134038024, 62403.37596624067, 62719.372806271356, 1418.8439271680106, 1431.6850292935537, 1443.9278036098153, 1473.690524989764, 1480.7719172204697, 31652.5252121223, 32175.51736723998, 32568.34863302768, 32990.17524561905, 33051.504227436126, 53041.0, 53778.0, 53812.73093634507, 53989.460105398444, 54060.459395405545, 426955.0, 427177.0, 428008.0, 428776.0, 428915.0, 30076.24809379783, 30666.693333066385, 30866.691333086383, 30891.382172355978, 31046.0, 48645.756771215914, 49797.0, 49887.50112498829, 50262.497375025785, 50331.74834125806, 40356.59643403528, 41099.58900411077, 41989.37015944702, 42118.36822447604, 42502.78748606237, 40236.59763402446, 40269.1946161081, 41459.37810932778, 41721.1655766889, 42036.0, 41168.0, 42015.579844201166, 42567.787161064, 42664.78667606642, 42968.78515607402, 35926.28147437089, 35994.46008309825, 36509.951309487085, 36747.63252367442, 36839.63160368469, 28545.0, 28701.28246793847, 31334.373312533167, 31909.521357179197, 31993.200169995936], "value": 20538.892251344452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.4519770908128, 424.30837734492775, 425.9616634502894, 432.3924885535822, 433.0775448295129, 18924.621507569842, 20121.496962575926, 20679.793202067976, 21450.89274553625, 21538.13847446104, 13672.179669219853, 17956.012419316932, 18967.62064758704, 19900.70148947767, 19932.60134797303, 5263.578913686905, 5429.647072940266, 5454.0, 5457.672539647634, 5497.092979658351, 5325.174597937326, 5405.486478784509, 5835.328937172237, 5877.970610146944, 5918.1418694289305, 5807.41925807418, 5837.036888913324, 5855.033919403293, 5862.32583252925, 5872.647641141524, 5839.153322768196, 6319.589226700273, 6633.13769210002, 6663.700133494004, 6754.9662251688915, 5875.618084824473, 5982.940170598282, 5991.970040149815, 6028.7588496460085, 6037.034074548052, 14942.477013304482, 15245.085294882232, 20050.699239511418, 23883.641745373832, 24389.0, 2186.7485239197536, 2322.5935461294375, 2342.121704360865, 2383.4279772854566, 2406.867622280774, 10598.947005264925, 10689.412082335468, 10984.340939543654, 11107.444627768578, 13334.533291334757, 1884.2274667386305, 1943.7473128493205, 1968.3897991622644, 2107.3361891004283, 2167.133146741316, 70007.0, 88131.67802482969, 90252.54873725655, 90485.09514904898, 90915.0, 11685.824712629317, 11765.470553825098, 12451.128421010624, 12521.747825217406, 12703.348564686716, 14745.41018359275, 17107.48677539676, 17166.0, 17229.91385043067, 17269.913650431667, 8146.877796833052, 8407.369447291478, 8413.411061225655, 8739.30085593151, 8749.956250218707, 8185.181481851886, 8194.22154895284, 8230.176982301842, 8282.958585207156, 8341.749747507585, 5138.3833939927445, 5169.715665638426, 5190.584753219733, 5229.137192363293, 5258.132408152612, 2142.153849229546, 2167.6640120781303, 2174.423542931362, 2191.101648324179, 2199.3292045926146, 968.4286271100085, 984.9162821160138, 1004.4626125023077, 1036.3678156324636, 1058.8517607534952, 19155.425337239903, 19743.210271588974, 20022.199112035356, 20129.09419076145, 20259.493512662302, 1054.4147997861107, 1066.1044722433194, 1072.6241375353472, 1077.1275267033727, 1077.4612693653173, 10835.566577336976, 11170.441477926071, 11284.605038823602, 11340.262882912584, 11422.714432139097, 527618.0, 540175.0, 544635.0, 553822.0, 554335.0, 98062.50968745253, 98065.50967245118, 98302.50848745853, 99324.0, 100199.0, 1071.2394200118003, 1074.1245884604023, 1083.0793825248634, 1088.9455527223606, 1100.471773548701, 17667.823321766617, 17708.0, 17826.0, 17929.193186306908, 18050.638987219918, 30826.845865770527, 36188.09529761777, 41200.793996031025, 42164.367534486395, 42926.78536607297, 58303.0, 58490.4150958485, 58888.70555647366, 59016.40983590281, 60609.69695151496, 8993.595288211915, 9186.954065229631, 9188.081191881025, 9339.112784285482, 9388.859167112361, 10054.748631284276, 10526.31578947366, 13365.331733413484, 13371.197728136343, 13768.518101866386, 11553.364564949008, 11817.586384476503, 11941.64175074749, 12111.405756064098, 12261.938690306848, 11543.4805433754, 11645.708857278298, 11687.240329378563, 11909.9882034971, 11957.641270761891, 11612.303261804318, 11835.28988260707, 12026.158168928441, 12047.939760301142, 12383.69040773988, 9062.954685226532, 9096.090390960851, 9203.079692030744, 9243.168114869693, 9256.398334108262, 10068.848967265643, 11949.820752688544, 11954.521819127138, 11991.64025079249, 12213.267203967791], "value": 9541.50347242817, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.317493673287, 1598.7362085255934, 1796.6047469556693, 1881.3227238194256, 1929.2958070304344, 8690.869636955435, 9323.673671421502, 9478.620855165786, 9912.603495860176, 9919.404835709853, 9506.429614223134, 9577.569009394576, 9579.760505987353, 9588.185004274628, 9636.229101671866, 2485.565026120431, 2502.336880726609, 2515.346010037385, 2537.5939849624065, 2538.4415428605676, 2423.5516429460517, 2426.7815896569305, 2430.5260474207535, 2435.062500937143, 2438.9390265243333, 2504.7745702886737, 2506.6240063990367, 2574.691037075544, 2575.343287461704, 2575.7295483974194, 2473.628955656648, 2487.3905893056226, 2495.3262619092743, 2503.086373473687, 2509.736477669846, 2439.1097249503982, 2458.2748089313695, 2461.5815311397105, 2462.8152888533255, 2469.0, 9565.282603804673, 9611.423314601147, 9639.373440726331, 9666.0, 9703.272254580865, 5597.384287728347, 5650.29371328584, 5670.092785154397, 5704.600677952545, 5728.828135155952, 3631.891043268706, 3708.8516459341595, 3741.1021354874633, 3742.4573436851774, 3751.255666115242, 1200.3518100225867, 1279.9424025918856, 1285.0554842190982, 1289.3682095773097, 1313.3695826003477, 13714.65713357174, 13751.656208594764, 13757.10578812374, 13854.515091971833, 13901.58295251144, 4940.357753492095, 4997.475265097185, 5122.334096567497, 5148.253503242009, 5163.690178589297, 11372.578427696539, 11403.201775875776, 11437.542498299976, 11455.083593312514, 11558.0, 5861.6189947653265, 5862.14998825168, 5893.6463812171405, 5920.37836027211, 5932.49573786233, 4604.37840891482, 5011.5489605935645, 5244.659097158673, 5269.578433725293, 5360.303160589098, 4312.525622181557, 4330.978345108318, 4336.067745434683, 4398.846040388635, 4403.163398954252, 1357.2806412601337, 1420.6732451536204, 1421.1047040364504, 1428.1573871415915, 1429.463951018368, 1017.1862509991977, 1033.235405799703, 1044.3733759744093, 1061.6337363609543, 1073.7959787640323, 6332.525060620472, 6502.44729198014, 6575.112359831362, 6633.900491492632, 6638.7676431325635, 482.49097202451753, 493.7259820799419, 1092.579356947581, 1121.327203677803, 1134.7900638381925, 4590.517995610479, 4630.438234360079, 4659.44086709597, 4697.0, 4786.545278198566, 11862.288262704265, 12234.388280585936, 12244.632661020183, 12310.199837010565, 12314.81527777084, 11443.885561144449, 11914.344711040803, 11928.880711192776, 12160.695982600506, 12220.633380998584, 8919.777005574782, 9057.365984381162, 9057.77355566116, 9061.13919177677, 9071.092890710876, 6429.690803711388, 6637.800865974028, 6754.662266886734, 6755.392014718699, 6831.863362732817, 10697.946510267398, 11040.723981900517, 11088.667339979813, 11176.776464470828, 11255.099592032782, 11337.603183888525, 11342.60300889465, 11356.921092496199, 11404.258723182966, 11500.424978750862, 7799.220077992155, 8559.10129436425, 8701.260392866678, 8822.470651760916, 9135.223506002065, 9231.538423078953, 9523.142917137491, 9529.380590261611, 9610.135087842127, 9617.471039092638, 8448.112948140602, 8575.442596231225, 8598.527081010605, 8666.78333041679, 8708.608112635073, 8486.872696909428, 8518.82962340762, 8523.190296921783, 8529.104444033288, 8576.31389488827, 7607.809804754926, 7623.771286861403, 7666.616669166631, 7678.577678227751, 7680.884786728316, 5171.250168725589, 5386.380566234777, 5587.07813210832, 5650.0, 5719.999000175036, 5687.345955215038, 5729.885402291848, 5739.196512488338, 5806.274215723035, 5822.679752613647], "value": 5080.724894665767, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.2637687233682, 352.3024411664903, 352.668491617879, 353.9699125574325, 356.86439153121825, 5668.404817494165, 5713.0, 5717.0, 5735.627184233027, 5737.99999999999, 5605.859853503654, 5613.607047506676, 5618.2415373924505, 5620.241267428896, 5623.437656234374, 3995.4606128172613, 4307.806148723315, 4327.221100201962, 4331.155424692186, 4351.543087975764, 4306.267934451151, 4344.283193273106, 4348.456442944632, 4355.194289056519, 4365.537544922439, 4307.418498502709, 4327.545607711177, 4333.934990975122, 4341.413909122275, 4345.3047512398025, 4232.555581663927, 4297.290946993758, 4304.806283717209, 4314.137172565468, 4316.525182229952, 3790.3177428062936, 3805.0677583991824, 3807.60020197878, 3810.6951443884423, 3830.616938306175, 5311.336082989626, 5349.358077030781, 5355.723817377599, 5364.275822763916, 5385.919211211796, 4857.886819233645, 4962.280469331963, 4986.326845875833, 4992.176290912032, 5011.223260394645, 5814.941850581482, 5835.416458354173, 5870.911936320958, 5881.2942446906645, 5916.4379383958885, 4214.578542145791, 4214.831406743757, 4262.0, 4266.381374700651, 4271.572842715735, 5966.134910437962, 5997.43152824069, 6000.549958753068, 6015.428534289235, 6073.4533891949495, 4255.29787585045, 4296.3125899856495, 4325.805338759764, 4339.500957389878, 4344.304911214191, 4328.458942632171, 4370.890727731832, 4380.890477738082, 4381.539938306496, 4401.735895846259, 4699.95300047002, 4940.827071052496, 4970.279309500174, 4971.1549036663855, 4978.551930326288, 5904.840910113069, 5909.852253693606, 5943.851403714942, 5972.581919265696, 6012.909806352908, 1488.0699562773266, 1492.417956996772, 1493.133982290269, 1501.4444655477325, 1502.5867886331346, 926.2775035472342, 943.4103535542632, 983.2723784399493, 996.2478328861663, 996.7209181429212, 5789.421057894177, 5820.76716931318, 5825.912611310834, 5834.649921004753, 5849.88300233993, 6018.187544681499, 6030.216071910623, 6069.787557435557, 6073.301570319381, 6085.269767627825, 5585.748641311151, 5670.68369167591, 5774.960507108761, 5778.162166485836, 5794.30468343793, 3175.412548678502, 3213.5057198402856, 3222.774405791572, 3224.822634755111, 3230.2570408806105, 6173.783917562864, 6280.796793635188, 6310.968445157745, 6322.36776322364, 6369.9171140906155, 6052.939470605325, 6084.0, 6109.84725381869, 6138.600990935575, 6153.661548614869, 6096.3903609639565, 6337.144485494491, 6341.873162536724, 6377.872442551123, 6378.170837791057, 5952.226210592596, 5998.400159983967, 6002.579819412599, 6019.0, 6046.244219472566, 5874.706264686834, 5925.496332811586, 5974.2233509643465, 5987.64074155552, 6033.396660334107, 6049.758009679739, 6360.681965901594, 6368.299487056327, 6370.426661600478, 6379.266384365857, 4214.915701685888, 4245.724027938298, 4256.446661934053, 4264.168487144977, 4275.251830929513, 5822.475977162076, 5969.820905372846, 5973.223480947449, 6043.365446628217, 6058.787942421994, 5853.473187412983, 5857.677827719516, 5874.441928016831, 5896.764129434775, 5897.734601942837, 5814.418558144321, 5828.708564571839, 5849.590528662953, 5852.94147058541, 5883.588148829541, 5546.639468434539, 5749.597528172988, 5756.4457596449565, 5872.265966754156, 5882.0, 5935.071101891816, 6022.350165926978, 6057.818265451867, 6060.939390606038, 6072.939270607238, 5611.775528978795, 5855.151003104611, 5868.735906884286, 5883.61756485827, 5891.469767720926], "value": 4487.385528955795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.9808504787379, 774.0169984120167, 792.2354927494968, 807.1766797866173, 901.1529162587169, 15733.134677592741, 16425.917870410645, 16682.082485463296, 16729.74905376417, 16810.0, 15272.0, 15451.613709657264, 15755.212239388013, 15788.289526971284, 15793.526194214162, 841.0958219913587, 844.6874656377149, 854.8076682746363, 855.56366253211, 873.9169778870997, 860.535310932099, 860.8880845490078, 864.1617630898019, 864.2653744317312, 864.5158711121792, 913.9497327646977, 914.4513292024799, 914.6752902719538, 914.9679761208359, 915.2997956563202, 906.2749800159879, 907.0340087806497, 910.8952470465915, 911.1617312072842, 911.3757076402685, 666.516775337881, 668.4151367553391, 671.2448495442627, 671.5097978475691, 671.6775947545157, 15961.802864785072, 16152.111633860133, 16230.83769162305, 16310.510684679479, 16328.265228064647, 14333.211673358066, 14631.0, 14634.41462341505, 14713.485028023968, 14761.409543618242, 12975.221486710732, 13039.152455090389, 13059.54291599799, 13121.540746073937, 13212.933935330359, 4014.116894283253, 4065.6137666921595, 4067.28822456069, 4098.631123198927, 4158.168366326717, 82974.0, 83055.5847220766, 83475.58262208711, 83782.16217837865, 83953.16046839576, 11885.16803823724, 11951.88048119525, 12069.094817888694, 12384.690382740504, 12446.751064978649, 20268.290609828586, 20330.79669203289, 20548.0, 20567.177312907315, 20588.691169632468, 9503.049695030442, 9604.95197524008, 9660.661876834278, 9661.323707340418, 9707.320487565943, 4572.634189264851, 4578.931316030262, 4624.352590637313, 4762.0, 4792.832250871203, 3760.2855457462992, 3880.0, 3891.630295121959, 3897.649211570972, 3898.493195884517, 677.190757045336, 695.1692727190958, 705.108038331511, 708.6988030087192, 722.4473277942378, 750.3359526818805, 770.1874522378944, 770.2567022823002, 780.1067777394851, 788.1440894156359, 10679.305845120043, 10801.945990270155, 10970.396628185366, 11106.777864442827, 11112.55549778016, 686.0669489494284, 725.3834240895197, 732.7765031665393, 738.7045181927272, 753.3972821742584, 5000.299958005882, 5150.0, 5154.896902061938, 5184.7407629618365, 5210.010098081352, 73739.0, 85910.0, 102028.48985755023, 120946.3952680231, 121883.0, 71993.28006719971, 76113.0, 99041.0, 101089.49455252677, 102041.48979255205, 91540.54229728809, 93254.0, 93503.0, 93513.06486935043, 93647.53176234211, 9580.946095929581, 9654.75863103428, 9717.465539395402, 9804.803903922024, 9891.307608467627, 53699.73150134224, 53887.0, 55213.44786552083, 55544.6113847157, 55822.162667560835, 78187.00849402392, 78384.0, 80059.19940800518, 80316.59841700754, 81001.59499202466, 13448.394822232827, 13452.46190152383, 13554.796678050034, 13641.24973126448, 13916.234607096707, 14343.354549045527, 14361.21013344276, 14391.136531808124, 14460.20468874222, 14864.62838429048, 13241.27173005494, 13388.665283367995, 13804.979335955566, 13825.377857996615, 14144.929275353557, 13409.128406653535, 13528.043087255899, 13621.182729036289, 13667.658308542366, 13803.015135145803, 13080.934595326962, 14187.935904806975, 14247.092863460879, 14382.0, 14890.181040042902, 11554.653360398865, 12044.21712588679, 12350.320732359447, 12392.289286624415, 12700.428480718205, 11702.824457632973, 12206.6948326289, 12267.938660306641, 12272.631821045383, 12650.683732906751], "value": 7934.54332966307, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 118.0, 110.0, 111.0, 110.0, 112.0, 110.0, 111.0, 111.0, 110.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 123.0, 156.0, 179.0, 128.0, 155.0, 154.0, 126.0, 186.0, 127.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 165.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 167.0, 75.0, 77.0, 75.0, 75.0, 182.0, 75.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 143.0, 85.0, 84.0, 85.0, 132.0, 84.0, 84.0, 140.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 146.0, 148.0, 148.0, 148.0, 148.0, 147.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 98.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 55.0, 52.0, 56.0, 54.0, 58.0, 54.0, 53.0, 56.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 64.0, 60.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 75.0, 78.0, 78.0, 78.0, 77.0, 106.0, 77.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 128.0, 126.0, 116.0, 117.0, 116.0, 121.0, 120.0, 130.0, 121.0], "value": 122.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 157.0, 152.0, 158.0, 151.0, 157.0, 150.0, 152.0, 154.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 63.0, 62.0, 62.0, 62.0, 60.0, 61.0, 60.0, 60.0], "value": 61.8, "unit": "score"}]}]} 03:08:34 INFO - Return code: 0 03:08:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:08:34 ERROR - # TBPL SUCCESS # 03:08:34 INFO - Running post-action listener: _resource_record_post_action 03:08:34 INFO - ##### 03:08:34 INFO - ##### Finished run-tests step (success) 03:08:34 INFO - ##### 03:08:34 INFO - Running post-run listener: _resource_record_post_run 03:08:34 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 491929600; Read time: 0; Write time: 374644 03:08:34 INFO - TinderboxPrint: CPU usage
13.3% 03:08:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:08:34 INFO - TinderboxPrint: I/O write bytes / time
491,929,600 / 374,644 03:08:34 INFO - TinderboxPrint: CPU idle
8,212.3 (86.6%) 03:08:34 INFO - TinderboxPrint: CPU user
1,209.2 (12.8%) 03:08:34 INFO - TinderboxPrint: Swap in / out
0 / 0 03:08:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242515968; Read time: 0; Write time: 226848 03:08:34 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 249413632; Read time: 0; Write time: 147796 03:08:35 INFO - Running post-run listener: _upload_blobber_files 03:08:35 INFO - Blob upload gear active. 03:08:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:08:35 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 03:08:35 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'] 03:08:35 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 03:08:35 INFO - (blobuploader) - INFO - Open directory for files ... 03:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:08:40 INFO - (blobuploader) - INFO - Done attempting. 03:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:08:41 INFO - (blobuploader) - INFO - Done attempting. 03:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:08:41 INFO - (blobuploader) - INFO - Done attempting. 03:08:41 INFO - (blobuploader) - INFO - Iteration through files over. 03:08:41 INFO - Return code: 0 03:08:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:08:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:08:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b082b26a9ac18ac8d286fd55154eebef7755bf3ab02f5fd47d29e8548cee8d20bac94f7caeeac3497764f423788a4f2e6e40a4b5a98c00fc3f1d75288d2ca0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67118601a95a1800c8d774cc05ce96153a66a494303660b43e4cee5b18ddec79b1f3f5b39b5cda935395b5190c29c2d175ab7c58907e57b63582977a06846c8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/995183d2d357be03b028f74196625e7ce3468cc687e35a89b842a376411ffcdfb9375ec5cea97c7f196d0bccf72edce210b24aec1c23999babc67225d63f56a6"} 03:08:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:08:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:08:41 INFO - Contents: 03:08:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b082b26a9ac18ac8d286fd55154eebef7755bf3ab02f5fd47d29e8548cee8d20bac94f7caeeac3497764f423788a4f2e6e40a4b5a98c00fc3f1d75288d2ca0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67118601a95a1800c8d774cc05ce96153a66a494303660b43e4cee5b18ddec79b1f3f5b39b5cda935395b5190c29c2d175ab7c58907e57b63582977a06846c8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/995183d2d357be03b028f74196625e7ce3468cc687e35a89b842a376411ffcdfb9375ec5cea97c7f196d0bccf72edce210b24aec1c23999babc67225d63f56a6"} 03:08:41 INFO - Running post-run listener: copy_logs_to_upload_dir 03:08:41 INFO - Copying logs to upload dir... 03:08:41 INFO - mkdir: /builds/slave/test/build/upload/logs 03:08:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.843721 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-01 03:08:41.534185) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 03:08:41.537824) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862 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/9b082b26a9ac18ac8d286fd55154eebef7755bf3ab02f5fd47d29e8548cee8d20bac94f7caeeac3497764f423788a4f2e6e40a4b5a98c00fc3f1d75288d2ca0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67118601a95a1800c8d774cc05ce96153a66a494303660b43e4cee5b18ddec79b1f3f5b39b5cda935395b5190c29c2d175ab7c58907e57b63582977a06846c8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/995183d2d357be03b028f74196625e7ce3468cc687e35a89b842a376411ffcdfb9375ec5cea97c7f196d0bccf72edce210b24aec1c23999babc67225d63f56a6"} 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.011279 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/9b082b26a9ac18ac8d286fd55154eebef7755bf3ab02f5fd47d29e8548cee8d20bac94f7caeeac3497764f423788a4f2e6e40a4b5a98c00fc3f1d75288d2ca0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67118601a95a1800c8d774cc05ce96153a66a494303660b43e4cee5b18ddec79b1f3f5b39b5cda935395b5190c29c2d175ab7c58907e57b63582977a06846c8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/995183d2d357be03b028f74196625e7ce3468cc687e35a89b842a376411ffcdfb9375ec5cea97c7f196d0bccf72edce210b24aec1c23999babc67225d63f56a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 03:08:41.563371) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:08:41.563707) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470044682.287427-660665862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 03:08:41.647249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 03:08:41.647582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 03:08:41.647874) ========= ========= Total master_lag: 0.17 =========