builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1465315649.18 results: success (0) buildid: 20160607074731 builduid: 4f1c4594514a4cd49e60f99f9c9a27b8 revision: ec20b463c04f57a4bfca1edb987fcb9e9707c364 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:29.177162) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:29.178082) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:29.178765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:29.194781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:29.195080) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 09:07:29-- 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% 113M=0s 2016-06-07 09:07:29 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093150 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:29.302465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:29.302802) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:29.352431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:29.352845) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ec20b463c04f57a4bfca1edb987fcb9e9707c364 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ec20b463c04f57a4bfca1edb987fcb9e9707c364 --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=82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 09:07:29,712 truncating revision to first 12 chars 2016-06-07 09:07:29,712 Setting DEBUG logging. 2016-06-07 09:07:29,713 attempt 1/10 2016-06-07 09:07:29,713 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ec20b463c04f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 09:07:30,017 unpacking tar archive at: mozilla-central-ec20b463c04f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:30.019362) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:30.019729) ========= script_repo_revision: ec20b463c04f57a4bfca1edb987fcb9e9707c364 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:30.020203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:30.020526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 09:07:30.030157) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-07 09:07:30.030524) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:07:30 INFO - MultiFileLogger online at 20160607 09:07:30 in /builds/slave/test 09:07:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:07:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:07:30 INFO - {'append_to_log': False, 09:07:30 INFO - 'base_work_dir': '/builds/slave/test', 09:07:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:07:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:07:30 INFO - 'branch': 'Firefox-Non-PGO', 09:07:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:07:30 INFO - 'config_files': ('talos/linux_config.py',), 09:07:30 INFO - 'default_actions': ('clobber', 09:07:30 INFO - 'read-buildbot-config', 09:07:30 INFO - 'download-and-extract', 09:07:30 INFO - 'populate-webroot', 09:07:30 INFO - 'create-virtualenv', 09:07:30 INFO - 'install', 09:07:30 INFO - 'run-tests'), 09:07:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:07:30 INFO - 'download_minidump_stackwalk': True, 09:07:30 INFO - 'download_symbols': 'ondemand', 09:07:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:07:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:07:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:07:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:07:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:07:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:07:30 INFO - 'installer_path': 'installer.exe', 09:07:30 INFO - 'log_level': 'info', 09:07:30 INFO - 'log_name': 'talos', 09:07:30 INFO - 'log_to_console': True, 09:07:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:07:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:07:30 INFO - 'opt_config_files': (), 09:07:30 INFO - 'pip_index': False, 09:07:30 INFO - 'sps_profile': False, 09:07:30 INFO - 'sps_profile_interval': 0, 09:07:30 INFO - 'suite': 'dromaeojs-e10s', 09:07:30 INFO - 'system_bits': '32', 09:07:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:07:30 INFO - 'title': 'talos-linux64-ix-066', 09:07:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:07:30 INFO - 'use_talos_json': True, 09:07:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:07:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:07:30 INFO - 'work_dir': 'build'} 09:07:30 INFO - ##### 09:07:30 INFO - ##### Running clobber step. 09:07:30 INFO - ##### 09:07:30 INFO - Running pre-action listener: _resource_record_pre_action 09:07:30 INFO - Running main action method: clobber 09:07:30 INFO - rmtree: /builds/slave/test/build 09:07:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:07:30 INFO - Running post-action listener: _resource_record_post_action 09:07:30 INFO - ##### 09:07:30 INFO - ##### Finished clobber step (success) 09:07:30 INFO - ##### 09:07:30 INFO - ##### 09:07:30 INFO - ##### Running read-buildbot-config step. 09:07:30 INFO - ##### 09:07:30 INFO - Running pre-action listener: _resource_record_pre_action 09:07:30 INFO - Running main action method: read_buildbot_config 09:07:30 INFO - Using buildbot properties: 09:07:30 INFO - { 09:07:30 INFO - "project": "", 09:07:30 INFO - "product": "firefox", 09:07:30 INFO - "script_repo_revision": "production", 09:07:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:07:30 INFO - "repository": "", 09:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:07:30 INFO - "buildid": "20160607074731", 09:07:30 INFO - "pgo_build": "False", 09:07:30 INFO - "basedir": "/builds/slave/test", 09:07:30 INFO - "buildnumber": 339, 09:07:30 INFO - "slavename": "talos-linux64-ix-066", 09:07:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:07:30 INFO - "platform": "ubuntu64_hw", 09:07:30 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:07:30 INFO - "branch": "mozilla-central", 09:07:30 INFO - "repo_path": "mozilla-central", 09:07:30 INFO - "revision": "ec20b463c04f57a4bfca1edb987fcb9e9707c364", 09:07:30 INFO - "stage_platform": "linux64", 09:07:30 INFO - "builduid": "4f1c4594514a4cd49e60f99f9c9a27b8", 09:07:30 INFO - "slavebuilddir": "test" 09:07:30 INFO - } 09:07:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:07:30 INFO - Running post-action listener: _resource_record_post_action 09:07:30 INFO - ##### 09:07:30 INFO - ##### Finished read-buildbot-config step (success) 09:07:30 INFO - ##### 09:07:30 INFO - ##### 09:07:30 INFO - ##### Running download-and-extract step. 09:07:30 INFO - ##### 09:07:30 INFO - Running pre-action listener: _resource_record_pre_action 09:07:30 INFO - Running main action method: download_and_extract 09:07:30 INFO - mkdir: /builds/slave/test/build/tests 09:07:30 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')]} 09:07:30 INFO - https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:07:35 INFO - Downloaded 1361 bytes. 09:07:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:07:35 INFO - Using the following test package requirements: 09:07:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:07:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:07:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:35 INFO - u'jsshell-linux-x86_64.zip'], 09:07:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:07:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:07:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:07:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:07:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:07:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:07: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')]} 09:07:35 INFO - https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:07:39 INFO - Downloaded 22878349 bytes. 09:07:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:07:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:07:41 INFO - Return code: 0 09:07:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:41 INFO - https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:07:42 INFO - Downloaded 22878349 bytes. 09:07:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:07:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:07:44 INFO - Return code: 0 09:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:44 INFO - https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:07:45 INFO - Downloaded 10833369 bytes. 09:07:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:07:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:07:45 INFO - Return code: 0 09:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:45 INFO - https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:07:46 INFO - Downloaded 55224032 bytes. 09:07:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:07:46 INFO - mkdir: /builds/slave/test/properties 09:07:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:07:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:07:46 INFO - Contents: 09:07:46 INFO - build_url:https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:07:47 INFO - Running post-action listener: _resource_record_post_action 09:07:47 INFO - Running post-action listener: set_extra_try_arguments 09:07:47 INFO - ##### 09:07:47 INFO - ##### Finished download-and-extract step (success) 09:07:47 INFO - ##### 09:07:47 INFO - ##### 09:07:47 INFO - ##### Running populate-webroot step. 09:07:47 INFO - ##### 09:07:47 INFO - Running pre-action listener: _resource_record_pre_action 09:07:47 INFO - Running main action method: populate_webroot 09:07:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:47 INFO - '--tppagecycles', 09:07:47 INFO - '7'], 09:07:47 INFO - 'tests': ['tsvgm']}}, 09:07:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:07:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:07:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:07:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:07:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:07:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:47 INFO - 'talos_options': ['--disable-e10s'], 09:07:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:47 INFO - 'talos_options': ['--disable-e10s'], 09:07:47 INFO - 'tests': ['damp', 'tps']}, 09:07:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:47 INFO - 'tests': ['damp', 'tps']}, 09:07:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:07:47 INFO - 'tests': ['dromaeo_dom']}, 09:07:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:07:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:07:47 INFO - 'tests': ['a11yr', 09:07:47 INFO - 'ts_paint', 09:07:47 INFO - 'tpaint', 09:07:47 INFO - 'sessionrestore', 09:07:47 INFO - 'sessionrestore_no_auto_restore', 09:07:47 INFO - 'tabpaint']}, 09:07:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:07:47 INFO - 'ts_paint', 09:07:47 INFO - 'tpaint', 09:07:47 INFO - 'sessionrestore', 09:07:47 INFO - 'sessionrestore_no_auto_restore', 09:07:47 INFO - 'tabpaint']}, 09:07:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:07:47 INFO - 'ts_paint', 09:07:47 INFO - 'tpaint', 09:07:47 INFO - 'sessionrestore', 09:07:47 INFO - 'sessionrestore_no_auto_restore', 09:07:47 INFO - 'tabpaint']}, 09:07:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:07:47 INFO - 'ts_paint', 09:07:47 INFO - 'tpaint', 09:07:47 INFO - 'sessionrestore', 09:07:47 INFO - 'sessionrestore_no_auto_restore', 09:07:47 INFO - 'tabpaint']}, 09:07:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:07:47 INFO - 'tests': ['a11yr', 09:07:47 INFO - 'ts_paint', 09:07:47 INFO - 'tpaint', 09:07:47 INFO - 'sessionrestore', 09:07:47 INFO - 'sessionrestore_no_auto_restore', 09:07:47 INFO - 'tabpaint']}, 09:07:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:07:47 INFO - 'tests': ['a11yr', 09:07:47 INFO - 'ts_paint', 09:07:47 INFO - 'tpaint', 09:07:47 INFO - 'sessionrestore', 09:07:47 INFO - 'sessionrestore_no_auto_restore', 09:07:47 INFO - 'tabpaint']}, 09:07:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:07:47 INFO - 'tests': ['tsvgx', 09:07:47 INFO - 'tsvgr_opacity', 09:07:47 INFO - 'tart', 09:07:47 INFO - 'tscrollx', 09:07:47 INFO - 'cart']}, 09:07:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:07:47 INFO - 'tsvgr_opacity', 09:07:47 INFO - 'tart', 09:07:47 INFO - 'tscrollx', 09:07:47 INFO - 'cart']}, 09:07:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:47 INFO - 'talos_options': ['--disable-e10s'], 09:07:47 INFO - 'tests': ['tp5o']}, 09:07:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:47 INFO - 'tests': ['tp5o']}, 09:07:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:47 INFO - 'talos_options': ['--disable-e10s', 09:07:47 INFO - '--xperf_path', 09:07:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:47 INFO - 'tests': ['tp5n']}, 09:07:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:47 INFO - 'talos_options': ['--xperf_path', 09:07:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:47 INFO - 'tests': ['tp5n']}}, 09:07:47 INFO - 'talos.zip': {'path': '', 09:07:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:47 INFO - Running post-action listener: _resource_record_post_action 09:07:47 INFO - ##### 09:07:47 INFO - ##### Finished populate-webroot step (success) 09:07:47 INFO - ##### 09:07:47 INFO - ##### 09:07:47 INFO - ##### Running create-virtualenv step. 09:07:47 INFO - ##### 09:07:47 INFO - Running pre-action listener: _resource_record_pre_action 09:07:47 INFO - Running main action method: create_virtualenv 09:07:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:07:47 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 09:07:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:07:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:47 INFO - Using real prefix '/usr' 09:07:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:07:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:07:50 INFO - Installing pip.................done. 09:07:50 INFO - Return code: 0 09:07:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:07:50 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')]} 09:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:50 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')]} 09:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:50 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 0x7f7daa39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', '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 09:07:50 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 09:07:50 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 09:07:50 INFO - Using env: {'DISPLAY': ':0', 09:07:50 INFO - 'HOME': '/home/cltbld', 09:07:50 INFO - 'LANG': 'en_US.UTF-8', 09:07:50 INFO - 'LANGUAGE': 'en_US:en', 09:07:50 INFO - 'LOGNAME': 'cltbld', 09:07:50 INFO - 'MAIL': '/var/mail/cltbld', 09:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:50 INFO - 'MOZ_NO_REMOTE': '1', 09:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:50 INFO - 'NO_EM_RESTART': '1', 09:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:50 INFO - 'PWD': '/builds/slave/test', 09:07:50 INFO - 'SHELL': '/bin/bash', 09:07:50 INFO - 'SHLVL': '1', 09:07:50 INFO - 'TERM': 'linux', 09:07:50 INFO - 'TMOUT': '86400', 09:07:50 INFO - 'USER': 'cltbld', 09:07:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', 09:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:50 INFO - '_': '/tools/buildbot/bin/python'} 09:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:50 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 09:07:50 INFO - Cleaning up... 09:07:50 INFO - Return code: 0 09:07:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:07:50 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')]} 09:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:50 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')]} 09:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:50 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 0x7f7daa39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', '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 09:07:50 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 09:07:50 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 09:07:50 INFO - Using env: {'DISPLAY': ':0', 09:07:50 INFO - 'HOME': '/home/cltbld', 09:07:50 INFO - 'LANG': 'en_US.UTF-8', 09:07:50 INFO - 'LANGUAGE': 'en_US:en', 09:07:50 INFO - 'LOGNAME': 'cltbld', 09:07:50 INFO - 'MAIL': '/var/mail/cltbld', 09:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:50 INFO - 'MOZ_NO_REMOTE': '1', 09:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:50 INFO - 'NO_EM_RESTART': '1', 09:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:50 INFO - 'PWD': '/builds/slave/test', 09:07:50 INFO - 'SHELL': '/bin/bash', 09:07:50 INFO - 'SHLVL': '1', 09:07:50 INFO - 'TERM': 'linux', 09:07:50 INFO - 'TMOUT': '86400', 09:07:50 INFO - 'USER': 'cltbld', 09:07:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', 09:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:50 INFO - '_': '/tools/buildbot/bin/python'} 09:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:50 INFO - Downloading/unpacking psutil>=3.1.1 09:07:50 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 09:07:50 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 09:07:50 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 09:07:50 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 09:07:50 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 09:07:50 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 09:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:07:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:52 INFO - Installing collected packages: psutil 09:07:52 INFO - Running setup.py install for psutil 09:07:52 INFO - building 'psutil._psutil_linux' extension 09:07:52 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 09:07:52 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 09:07:52 INFO - building 'psutil._psutil_posix' extension 09:07:52 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 09:07:52 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 09:07:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:53 INFO - Successfully installed psutil 09:07:53 INFO - Cleaning up... 09:07:53 INFO - Return code: 0 09:07:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:07:53 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')]} 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:53 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')]} 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:53 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 0x7f7daa39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', '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 09:07:53 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 09:07:53 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 09:07:53 INFO - Using env: {'DISPLAY': ':0', 09:07:53 INFO - 'HOME': '/home/cltbld', 09:07:53 INFO - 'LANG': 'en_US.UTF-8', 09:07:53 INFO - 'LANGUAGE': 'en_US:en', 09:07:53 INFO - 'LOGNAME': 'cltbld', 09:07:53 INFO - 'MAIL': '/var/mail/cltbld', 09:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:53 INFO - 'MOZ_NO_REMOTE': '1', 09:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:53 INFO - 'NO_EM_RESTART': '1', 09:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:53 INFO - 'PWD': '/builds/slave/test', 09:07:53 INFO - 'SHELL': '/bin/bash', 09:07:53 INFO - 'SHLVL': '1', 09:07:53 INFO - 'TERM': 'linux', 09:07:53 INFO - 'TMOUT': '86400', 09:07:53 INFO - 'USER': 'cltbld', 09:07:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', 09:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:53 INFO - '_': '/tools/buildbot/bin/python'} 09:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:07:55 INFO - Installing collected packages: mozsystemmonitor 09:07:55 INFO - Running setup.py install for mozsystemmonitor 09:07:55 INFO - Successfully installed mozsystemmonitor 09:07:55 INFO - Cleaning up... 09:07:55 INFO - Return code: 0 09:07:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7daa39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', '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 09:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:07:55 INFO - Using env: {'DISPLAY': ':0', 09:07:55 INFO - 'HOME': '/home/cltbld', 09:07:55 INFO - 'LANG': 'en_US.UTF-8', 09:07:55 INFO - 'LANGUAGE': 'en_US:en', 09:07:55 INFO - 'LOGNAME': 'cltbld', 09:07:55 INFO - 'MAIL': '/var/mail/cltbld', 09:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:55 INFO - 'MOZ_NO_REMOTE': '1', 09:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:55 INFO - 'NO_EM_RESTART': '1', 09:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:55 INFO - 'PWD': '/builds/slave/test', 09:07:55 INFO - 'SHELL': '/bin/bash', 09:07:55 INFO - 'SHLVL': '1', 09:07:55 INFO - 'TERM': 'linux', 09:07:55 INFO - 'TMOUT': '86400', 09:07:55 INFO - 'USER': 'cltbld', 09:07:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', 09:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:55 INFO - '_': '/tools/buildbot/bin/python'} 09:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:55 INFO - Downloading/unpacking jsonschema==2.5.1 09:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:07:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:07:57 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 09:07:57 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 09:07:57 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 09:07:57 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 09:07:57 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 09:07:57 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 09:07:57 INFO - Downloading functools32-3.2.3-2.tar.gz 09:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:07:57 INFO - warning: no files found matching '*.txt' 09:07:57 INFO - no previously-included directories found matching 'build' 09:07:57 INFO - no previously-included directories found matching 'dist' 09:07:57 INFO - no previously-included directories found matching '.git*' 09:07:57 INFO - Installing collected packages: jsonschema, functools32 09:07:57 INFO - Running setup.py install for functools32 09:07:57 INFO - warning: no files found matching '*.txt' 09:07:57 INFO - no previously-included directories found matching 'build' 09:07:57 INFO - no previously-included directories found matching 'dist' 09:07:57 INFO - no previously-included directories found matching '.git*' 09:07:57 INFO - Successfully installed jsonschema functools32 09:07:57 INFO - Cleaning up... 09:07:57 INFO - Return code: 0 09:07:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7daa39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', '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 09:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:07:57 INFO - Using env: {'DISPLAY': ':0', 09:07:57 INFO - 'HOME': '/home/cltbld', 09:07:57 INFO - 'LANG': 'en_US.UTF-8', 09:07:57 INFO - 'LANGUAGE': 'en_US:en', 09:07:57 INFO - 'LOGNAME': 'cltbld', 09:07:57 INFO - 'MAIL': '/var/mail/cltbld', 09:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:57 INFO - 'MOZ_NO_REMOTE': '1', 09:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:57 INFO - 'NO_EM_RESTART': '1', 09:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:57 INFO - 'PWD': '/builds/slave/test', 09:07:57 INFO - 'SHELL': '/bin/bash', 09:07:57 INFO - 'SHLVL': '1', 09:07:57 INFO - 'TERM': 'linux', 09:07:57 INFO - 'TMOUT': '86400', 09:07:57 INFO - 'USER': 'cltbld', 09:07:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', 09:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:57 INFO - '_': '/tools/buildbot/bin/python'} 09:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:58 INFO - Downloading/unpacking blobuploader==1.2.4 09:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:00 INFO - Downloading blobuploader-1.2.4.tar.gz 09:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:08:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:08:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:00 INFO - Downloading docopt-0.6.1.tar.gz 09:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:08:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:08:00 INFO - Running setup.py install for blobuploader 09:08:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:08:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:08:00 INFO - Running setup.py install for requests 09:08:01 INFO - Running setup.py install for docopt 09:08:01 INFO - Successfully installed blobuploader requests docopt 09:08:01 INFO - Cleaning up... 09:08:01 INFO - Return code: 0 09:08:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08: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')]} 09:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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')]} 09:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:01 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 0x7f7daa39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', '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 09:08:01 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 09:08:01 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 09:08:01 INFO - Using env: {'DISPLAY': ':0', 09:08:01 INFO - 'HOME': '/home/cltbld', 09:08:01 INFO - 'LANG': 'en_US.UTF-8', 09:08:01 INFO - 'LANGUAGE': 'en_US:en', 09:08:01 INFO - 'LOGNAME': 'cltbld', 09:08:01 INFO - 'MAIL': '/var/mail/cltbld', 09:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:01 INFO - 'MOZ_NO_REMOTE': '1', 09:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:01 INFO - 'NO_EM_RESTART': '1', 09:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:01 INFO - 'PWD': '/builds/slave/test', 09:08:01 INFO - 'SHELL': '/bin/bash', 09:08:01 INFO - 'SHLVL': '1', 09:08:01 INFO - 'TERM': 'linux', 09:08:01 INFO - 'TMOUT': '86400', 09:08:01 INFO - 'USER': 'cltbld', 09:08:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', 09:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:01 INFO - '_': '/tools/buildbot/bin/python'} 09:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:01 INFO - Running setup.py (path:/tmp/pip-4oGyku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:01 INFO - Running setup.py (path:/tmp/pip-MEZbLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:01 INFO - Running setup.py (path:/tmp/pip-bxmRCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:01 INFO - Running setup.py (path:/tmp/pip-g4YXjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:01 INFO - Running setup.py (path:/tmp/pip-qo5Vlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:01 INFO - Running setup.py (path:/tmp/pip-MCW7Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:02 INFO - Running setup.py (path:/tmp/pip-IWWsvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:02 INFO - Running setup.py (path:/tmp/pip-my61wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:02 INFO - Running setup.py (path:/tmp/pip-5hCrlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:02 INFO - Running setup.py (path:/tmp/pip-nfPX6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:02 INFO - Running setup.py (path:/tmp/pip-RyWGoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:02 INFO - Running setup.py (path:/tmp/pip-cdZu3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:02 INFO - Running setup.py (path:/tmp/pip-nx6SuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:02 INFO - Running setup.py (path:/tmp/pip-s5_DGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:02 INFO - Running setup.py (path:/tmp/pip-NATEqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:02 INFO - Running setup.py (path:/tmp/pip-JvU2Fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:02 INFO - Running setup.py (path:/tmp/pip-BptfzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:08:02 INFO - Running setup.py install for manifestparser 09:08:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:08:02 INFO - Running setup.py install for mozcrash 09:08:03 INFO - Running setup.py install for mozdebug 09:08:03 INFO - Running setup.py install for mozdevice 09:08:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:08:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:08:03 INFO - Running setup.py install for mozfile 09:08:03 INFO - Running setup.py install for mozhttpd 09:08:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:08:03 INFO - Running setup.py install for mozinfo 09:08:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:08:03 INFO - Running setup.py install for mozInstall 09:08:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:08:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:08:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:08:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:08:03 INFO - Running setup.py install for mozleak 09:08:03 INFO - Running setup.py install for mozlog 09:08:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:08:03 INFO - Running setup.py install for moznetwork 09:08:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:08:03 INFO - Running setup.py install for mozprocess 09:08:04 INFO - Running setup.py install for mozprofile 09:08:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:08:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:08:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:08:04 INFO - Running setup.py install for mozrunner 09:08:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:08:04 INFO - Running setup.py install for mozscreenshot 09:08:04 INFO - Running setup.py install for moztest 09:08:04 INFO - Running setup.py install for mozversion 09:08:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:08:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:08:04 INFO - Cleaning up... 09:08:04 INFO - Return code: 0 09:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:04 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 0x7f7daa39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', '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 09:08:04 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 09:08:04 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 09:08:04 INFO - Using env: {'DISPLAY': ':0', 09:08:04 INFO - 'HOME': '/home/cltbld', 09:08:04 INFO - 'LANG': 'en_US.UTF-8', 09:08:04 INFO - 'LANGUAGE': 'en_US:en', 09:08:04 INFO - 'LOGNAME': 'cltbld', 09:08:04 INFO - 'MAIL': '/var/mail/cltbld', 09:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:04 INFO - 'MOZ_NO_REMOTE': '1', 09:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:04 INFO - 'NO_EM_RESTART': '1', 09:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:04 INFO - 'PWD': '/builds/slave/test', 09:08:04 INFO - 'SHELL': '/bin/bash', 09:08:04 INFO - 'SHLVL': '1', 09:08:04 INFO - 'TERM': 'linux', 09:08:04 INFO - 'TMOUT': '86400', 09:08:04 INFO - 'USER': 'cltbld', 09:08:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', 09:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:04 INFO - '_': '/tools/buildbot/bin/python'} 09:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:04 INFO - Running setup.py (path:/tmp/pip-gj0raD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:04 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)) 09:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:04 INFO - Running setup.py (path:/tmp/pip-HMu7KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:05 INFO - Running setup.py (path:/tmp/pip-rA7g4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:05 INFO - Running setup.py (path:/tmp/pip-u25skb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:05 INFO - Running setup.py (path:/tmp/pip-fJsyuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:05 INFO - Running setup.py (path:/tmp/pip-Ta37ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:05 INFO - Running setup.py (path:/tmp/pip-mYQofD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:05 INFO - Running setup.py (path:/tmp/pip-FVzofJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:05 INFO - Running setup.py (path:/tmp/pip-urCBMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:05 INFO - Running setup.py (path:/tmp/pip-nwE0hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:05 INFO - Running setup.py (path:/tmp/pip-ZGaNtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:05 INFO - Running setup.py (path:/tmp/pip-Wte1oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:05 INFO - Running setup.py (path:/tmp/pip-J4NFEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:05 INFO - Running setup.py (path:/tmp/pip-Qx2sIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:05 INFO - Running setup.py (path:/tmp/pip-OjVJiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:05 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)) 09:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:05 INFO - Running setup.py (path:/tmp/pip-GF72Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08:06 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)) 09:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:06 INFO - Running setup.py (path:/tmp/pip-NxyUqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08:06 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)) 09:08:06 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)) 09:08:06 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)) 09:08:06 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)) 09:08:06 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)) 09:08:06 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)) 09:08:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:08:06 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 09:08:06 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 09:08:06 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 09:08:06 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 09:08:06 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 09:08:06 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 09:08:07 INFO - Downloading blessings-1.6.tar.gz 09:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:08:08 INFO - Installing collected packages: blessings 09:08:08 INFO - Running setup.py install for blessings 09:08:08 INFO - Successfully installed blessings 09:08:08 INFO - Cleaning up... 09:08:08 INFO - Return code: 0 09:08:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:08 INFO - Reading from file tmpfile_stdout 09:08:08 INFO - Current package versions: 09:08:08 INFO - argparse == 1.2.1 09:08:08 INFO - blessings == 1.6 09:08:08 INFO - blobuploader == 1.2.4 09:08:08 INFO - docopt == 0.6.1 09:08:08 INFO - functools32 == 3.2.3-2 09:08:08 INFO - jsonschema == 2.5.1 09:08:08 INFO - manifestparser == 1.1 09:08:08 INFO - mozInstall == 1.12 09:08:08 INFO - mozcrash == 0.17 09:08:08 INFO - mozdebug == 0.1 09:08:08 INFO - mozdevice == 0.48 09:08:08 INFO - mozfile == 1.2 09:08:08 INFO - mozhttpd == 0.7 09:08:08 INFO - mozinfo == 0.9 09:08:08 INFO - mozleak == 0.1 09:08:08 INFO - mozlog == 3.2 09:08:08 INFO - moznetwork == 0.27 09:08:08 INFO - mozprocess == 0.22 09:08:08 INFO - mozprofile == 0.28 09:08:08 INFO - mozrunner == 6.11 09:08:08 INFO - mozscreenshot == 0.1 09:08:08 INFO - mozsystemmonitor == 0.3 09:08:08 INFO - moztest == 0.7 09:08:08 INFO - mozversion == 1.4 09:08:08 INFO - psutil == 3.1.1 09:08:08 INFO - requests == 1.2.3 09:08:08 INFO - wsgiref == 0.1.2 09:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:08 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 0x7f7daa39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', '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 09:08:08 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 09:08:08 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 09:08:08 INFO - Using env: {'DISPLAY': ':0', 09:08:08 INFO - 'HOME': '/home/cltbld', 09:08:08 INFO - 'LANG': 'en_US.UTF-8', 09:08:08 INFO - 'LANGUAGE': 'en_US:en', 09:08:08 INFO - 'LOGNAME': 'cltbld', 09:08:08 INFO - 'MAIL': '/var/mail/cltbld', 09:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:08 INFO - 'MOZ_NO_REMOTE': '1', 09:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:08 INFO - 'NO_EM_RESTART': '1', 09:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:08 INFO - 'PWD': '/builds/slave/test', 09:08:08 INFO - 'SHELL': '/bin/bash', 09:08:08 INFO - 'SHLVL': '1', 09:08:08 INFO - 'TERM': 'linux', 09:08:08 INFO - 'TMOUT': '86400', 09:08:08 INFO - 'USER': 'cltbld', 09:08:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', 09:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:08 INFO - '_': '/tools/buildbot/bin/python'} 09:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:08 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)) 09:08:08 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)) 09:08:08 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)) 09:08:08 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)) 09:08:08 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)) 09:08:08 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)) 09:08:08 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)) 09:08:08 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)) 09:08:08 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)) 09:08:08 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)) 09:08:08 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)) 09:08:08 INFO - Cleaning up... 09:08:08 INFO - Return code: 0 09:08:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7daa39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', '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 09:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:08:08 INFO - Using env: {'DISPLAY': ':0', 09:08:08 INFO - 'HOME': '/home/cltbld', 09:08:08 INFO - 'LANG': 'en_US.UTF-8', 09:08:08 INFO - 'LANGUAGE': 'en_US:en', 09:08:08 INFO - 'LOGNAME': 'cltbld', 09:08:08 INFO - 'MAIL': '/var/mail/cltbld', 09:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:08 INFO - 'MOZ_NO_REMOTE': '1', 09:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:08 INFO - 'NO_EM_RESTART': '1', 09:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:08 INFO - 'PWD': '/builds/slave/test', 09:08:08 INFO - 'SHELL': '/bin/bash', 09:08:08 INFO - 'SHLVL': '1', 09:08:08 INFO - 'TERM': 'linux', 09:08:08 INFO - 'TMOUT': '86400', 09:08:08 INFO - 'USER': 'cltbld', 09:08:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', 09:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:08 INFO - '_': '/tools/buildbot/bin/python'} 09:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:08:08 INFO - Cleaning up... 09:08:08 INFO - Return code: 0 09:08:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7daa39ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', '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 09:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:08:08 INFO - Using env: {'DISPLAY': ':0', 09:08:08 INFO - 'HOME': '/home/cltbld', 09:08:08 INFO - 'LANG': 'en_US.UTF-8', 09:08:08 INFO - 'LANGUAGE': 'en_US:en', 09:08:08 INFO - 'LOGNAME': 'cltbld', 09:08:08 INFO - 'MAIL': '/var/mail/cltbld', 09:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:08 INFO - 'MOZ_NO_REMOTE': '1', 09:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:08 INFO - 'NO_EM_RESTART': '1', 09:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:08 INFO - 'PWD': '/builds/slave/test', 09:08:08 INFO - 'SHELL': '/bin/bash', 09:08:08 INFO - 'SHLVL': '1', 09:08:08 INFO - 'TERM': 'linux', 09:08:08 INFO - 'TMOUT': '86400', 09:08:08 INFO - 'USER': 'cltbld', 09:08:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', 09:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:08 INFO - '_': '/tools/buildbot/bin/python'} 09:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:09 INFO - Downloading/unpacking flake8 09:08:09 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 09:08:09 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 09:08:09 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 09:08:09 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 09:08:09 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 09:08:09 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 09:08:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:08:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:08:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:08:11 INFO - no previously-included directories found matching 'docs/_build' 09:08:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:08:11 INFO - Running setup.py install for pep8 09:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:08:11 INFO - no previously-included directories found matching 'docs/_build' 09:08:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:08:11 INFO - Cleaning up... 09:08:11 INFO - Return code: 0 09:08:11 INFO - Running post-action listener: _resource_record_post_action 09:08:11 INFO - Running post-action listener: _start_resource_monitoring 09:08:11 INFO - Starting resource monitoring. 09:08:11 INFO - ##### 09:08:11 INFO - ##### Finished create-virtualenv step (success) 09:08:11 INFO - ##### 09:08:11 INFO - ##### 09:08:11 INFO - ##### Running install step. 09:08:11 INFO - ##### 09:08:11 INFO - Running pre-action listener: _resource_record_pre_action 09:08:11 INFO - Running main action method: install 09:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:12 INFO - Reading from file tmpfile_stdout 09:08:12 INFO - Detecting whether we're running mozinstall >=1.0... 09:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:08:12 INFO - Reading from file tmpfile_stdout 09:08:12 INFO - Output received: 09:08:12 INFO - Usage: mozinstall [options] installer 09:08:12 INFO - Options: 09:08:12 INFO - -h, --help show this help message and exit 09:08:12 INFO - -d DEST, --destination=DEST 09:08:12 INFO - Directory to install application into. [default: 09:08:12 INFO - "/builds/slave/test"] 09:08:12 INFO - --app=APP Application being installed. [default: firefox] 09:08:12 INFO - mkdir: /builds/slave/test/build/application 09:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:08:28 INFO - Reading from file tmpfile_stdout 09:08:28 INFO - Output received: 09:08:28 INFO - /builds/slave/test/build/application/firefox/firefox 09:08:28 INFO - Running post-action listener: _resource_record_post_action 09:08:28 INFO - ##### 09:08:28 INFO - ##### Finished install step (success) 09:08:28 INFO - ##### 09:08:28 INFO - ##### 09:08:28 INFO - ##### Running run-tests step. 09:08:28 INFO - ##### 09:08:28 INFO - Running pre-action listener: _resource_record_pre_action 09:08:28 INFO - Running main action method: run_tests 09:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:08:28 INFO - Python 2.7.3 09:08:28 INFO - Return code: 0 09:08:28 INFO - grabbing minidump binary from tooltool 09:08: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')]} 09:08:28 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 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:08:28 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 09:08:28 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 09:08:28 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 09:08:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:08:28 INFO - Return code: 0 09:08:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:08:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:08:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:08:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:08:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:08:29 INFO - Return code: 0 09:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 09:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 09:08:29 INFO - Using env: {'DISPLAY': ':0', 09:08:29 INFO - 'HOME': '/home/cltbld', 09:08:29 INFO - 'LANG': 'en_US.UTF-8', 09:08:29 INFO - 'LANGUAGE': 'en_US:en', 09:08:29 INFO - 'LOGNAME': 'cltbld', 09:08:29 INFO - 'MAIL': '/var/mail/cltbld', 09:08:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:08:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:29 INFO - 'MOZ_NO_REMOTE': '1', 09:08:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:29 INFO - 'NO_EM_RESTART': '1', 09:08:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:29 INFO - 'PWD': '/builds/slave/test', 09:08:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:08:29 INFO - 'SHELL': '/bin/bash', 09:08:29 INFO - 'SHLVL': '1', 09:08:29 INFO - 'TERM': 'linux', 09:08:29 INFO - 'TMOUT': '86400', 09:08:29 INFO - 'USER': 'cltbld', 09:08:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061', 09:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:29 INFO - '_': '/tools/buildbot/bin/python'} 09:08:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 09:08:29 INFO - mozversion application_buildid: 20160607074731 09:08:29 INFO - mozversion application_changeset: ec20b463c04f57a4bfca1edb987fcb9e9707c364 09:08:29 INFO - mozversion application_display_name: Nightly 09:08:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:08:29 INFO - mozversion application_name: Firefox 09:08:29 INFO - mozversion application_remotingname: firefox 09:08:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:08:29 INFO - mozversion application_vendor: Mozilla 09:08:29 INFO - mozversion application_version: 50.0a1 09:08:29 INFO - mozversion platform_buildid: 20160607074731 09:08:29 INFO - mozversion platform_changeset: ec20b463c04f57a4bfca1edb987fcb9e9707c364 09:08:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:08:29 INFO - mozversion platform_version: 50.0a1 09:08:29 INFO - using testdate: 1465315709 09:08:29 INFO - actual date: 1465315709 09:08:29 INFO - starting webserver on 'localhost:41915' 09:08:29 INFO - SUITE-START | Running 2 tests 09:08:29 INFO - TEST-START | dromaeo_css 09:08:29 INFO - operating with platform_type : linux_ 09:08:29 INFO - Initialising browser for dromaeo_css test... 09:08:29 INFO - TEST-INFO | started process 29700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpheZSX8/profile http://localhost:41915/getInfo.html) 09:08:34 INFO - PROCESS | 29700 | __metrics Screen width/height:1600/1200 09:08:34 INFO - PROCESS | 29700 | colorDepth:24 09:08:34 INFO - PROCESS | 29700 | Browser inner width/height: 1024/697 09:08:34 INFO - PROCESS | 29700 | __metrics 09:08:35 ERROR - PROCESS | 29700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:08:36 INFO - TEST-INFO | 29700: exit 0 09:08:36 INFO - Browser initialized. 09:08:36 INFO - Running cycle 1/1 for dromaeo_css test... 09:08:36 INFO - TEST-INFO | started process 29820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpheZSX8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:48 INFO - PROCESS | 29820 | RSS: Main: 168587264 09:08:48 INFO - PROCESS | 29820 | 09:09:38 INFO - PROCESS | 29820 | 1465315778099 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] 09:11:49 INFO - PROCESS | 29820 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41915/tests/dromaeo/cssquery-ext.html) 09:11:51 INFO - PROCESS | 29820 | RSS: Main: 171122688 09:11:51 INFO - PROCESS | 29820 | 09:14:53 INFO - PROCESS | 29820 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-ext.html (next: http://localhost:41915/tests/dromaeo/cssquery-jquery.html) 09:14:53 INFO - PROCESS | 29820 | RSS: Main: 171380736 09:14:53 INFO - PROCESS | 29820 | 09:17:55 INFO - PROCESS | 29820 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41915/tests/dromaeo/cssquery-mootools.html) 09:17:56 INFO - PROCESS | 29820 | RSS: Main: 171991040 09:17:56 INFO - PROCESS | 29820 | 09:20:58 INFO - PROCESS | 29820 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41915/tests/dromaeo/cssquery-prototype.html) 09:20:58 INFO - PROCESS | 29820 | RSS: Main: 169697280 09:20:58 INFO - PROCESS | 29820 | 09:24:01 INFO - PROCESS | 29820 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41915/tests/dromaeo/cssquery-yui.html) 09:24:02 INFO - PROCESS | 29820 | RSS: Main: 171220992 09:24:02 INFO - PROCESS | 29820 | 09:27:04 INFO - PROCESS | 29820 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-yui.html (next: http://localhost:41915/tests/dromaeo/cssquery-dojo.html) 09:27:05 INFO - PROCESS | 29820 | RSS: Main: 173178880 09:27:05 INFO - PROCESS | 29820 | 09:27:05 INFO - PROCESS | 29820 | __start_tp_report 09:27:05 INFO - PROCESS | 29820 | _x_x_mozilla_page_load 09:27:05 INFO - PROCESS | 29820 | _x_x_mozilla_page_load_details 09:27:05 INFO - PROCESS | 29820 | |i|pagename|runs| 09:27:05 INFO - PROCESS | 29820 | |0;dojo.html;2653.2040387883635;2711.3492761737175;2713.1996061161954;2734.6444962154915;2734.9863250683743;4795.280707893813;4829.806807727691;4869.586085182759;4929.433115191754;4986.875328116799;4836.3470931424245;4847;4904.828331008415;4934.80260789568;4936.210206366982;4389.626881715058;4409.977950110245;4494.303382975644;4548.431446069241;4550.863474095782;4229.302165142748;4581.725096494204;4634.050019745944;4641.25739881619;4674.859754207362;4398.824047038114;4434.2905135178535;4465.665075119379;4484.753338566377;4545.6802629879985;4446.710963787344;4458.7324760514475;4471.1728330259;4472.217361961643;4491.326301054868;4399.098184872094;4440.733555986619;4464.129494748526;4468.575485328888;4485.842995495142;4687.367205427257;4761.785719642625;4806.423229212482;4815.181419158752;4847.345608342864;5186;5215.113430716788;5224.817131400421;5248.763805628756;5263.6841789492755;5240.004399164185;5273.209018647195;5289.709066001368;5290.629655924087;5311.654742441768;4920.6309526785635;4961.255811628249;4964.280179373971;4971.751412429364;5017.82437614689;5431.5926305526455;5433.429489903582;5444.754986025639;5448;5450.04624190765;5037.949620503748;5106.463821298785;5129.435762066169;5153.2785410042625;5158.509941555546;5133.666311689803;5232.633715639869;5261.947380526222;5262.2632831403635;5263.815766448156;5151.150060240094;5195.558377537876;5214.504622060898;5223.817166399158;5233.4243233244315;5076.18780995039;5104.05574968632;5125.846224613268;5209.791608335624;5231.633785634969;4429.047754732748;4457.531959144308;4463.7991290391365;4489.88775280614;4490.775461226991;3825.3496905526126;3864.555576108727;3876.2828876657345;3900.5904380039688;3913.099987002948;4416.315471101984;4447.977760111244;4470.6870519064005;4474.038081812426;4521.367008618796;5266.631335806534;5285.973570132125;5302.522772950376;5321.547668448148;5326.467353264643;4474.0604473060375;4485.932711009337;4488.259437192892;4489.910201795946;4541.772911354419;4631.235846085426;4755.785989630475;4777.4267087949665;4784.138855006063;4844.442889067732;4893.094777466109;4904.534069263557;4939.629527785431;4946.455889852042;4990.251462280615;5355.357357117171;5379.919301210563;5381.838544843661;5398.973005134949;5436.809711660073;4722.338872557913;4808.855734327975;4837.7097374157665;4938.901221975612;4943.283223932582;5190.40310364313;5192.610554208525;5195.220716892496;5225.451327610698;5230.215467679878;5270.762815673381;5283.392409872914;5311.548518375981;5311.654742441729;5372.973135134299;4921.926171107365;5070.41690205631;5080.136376815876;5091.185410334477;5113.7187454688865;4917.508249175054;4983.177775666974;4997.300377947017;5067.163917953497;5074.06129865976;4968.22992436173;5001.374828146481;5001.824936127218;5013.39839219296;5023.296738456546;4973.801047958041;5074.923876141935;5098.770555324945;5110.821121260738;5119.948800512097;5005.824796132118;5043.697378157322;5054.519820617035;5065.974670126626;5121.820736274212 09:27:05 INFO - PROCESS | 29820 | |1;ext.html;565.0930256937615;583.2592607388617;587.1134586773971;597.9850503737406;605.152786099461;29858;33265.501017484756;33285.500717489194;33409.66590334099;33514.66485335146;37363.813180934056;37619.059523511925;37830;37860;38138.23723525528;7603.733869314561;7766.961165194194;7800.648970796299;7801.5709135997495;7805.258500442449;7716.6527506262355;7764.844703105934;7780.766577002699;7789.454738168331;7816.062072551274;7704.422168337397;7757.26306000929;7789.8052548686455;7815.687372505093;7823.569703666296;7769.300762931307;7771.455998080109;7795.883061754078;7800.492967957121;7811.882821757678;7635.885461718079;7721.7683469496005;7726.0342457192855;7735.265149810759;7780.14418413974;35344.82327588371;35813;35945.10137246564;35970.460443093114;36044.279114417826;2696.5955106734145;2782.8052036357462;2807.4244779820087;2868.885244590214;2931.3697555025774;28141;28296.292592685142;28329.433411331865;28345.149645510668;28697.139085827457;3472.774269672463;3521.559805024372;3542.71658267338;3624.3476174288617;3628.147385364464;185868;186515;186797;187262;187512;50203.748981255594;50632.746836265585;50642;50746;50775.746121269156;32563.348733025206;33200.83399583035;33320.833395832866;35108;52995;14478.85521144796;14562;14645.707085858223;14687;14735.189564573837;11234.49444774987;11293.774124517628;11311.773764524663;11339.94330028361;11394.37330946806;17920.462386128438;17933.551661208574;17978.64042719138;18087.36694215696;18099.72850407245;6693.330666933268;6930.168379794457;7016.298370162943;7074.045003924404;7138.857222855514;840.7183593496125;939.3706216834737;975.2782940623887;985.1724551376877;1031.138998935882;26174.34564135912;27246.5913011305;27308.859481159525;27527.724722752515;27735.72264277372;980.9313348065709;994.0953732103751;994.786120983992;1041.9322744021615;1055.1189756553365;14079.225642589756;14586.361751762137;14644.707105857824;14713.485028023968;14903.180325082008;407109;408554;413077;414523;415779;45497.772511137235;46681.53318466772;46736.2989555157;47104.5289547107;47218.5278147221;1139.8062329404022;1246.5637027040464;1254.4982007197011;1257.270782945889;1269.57469247803;25601;26382.604260935717;26514.469710605295;26751.197464076107;26787.19638410851;40844.387334189414;41128;41391.58608413878;41653.166936661706;41819.581804181566;325332;325479;327279;328931;329485;22361.44096397603;24389.51220975606;24627.507449851262;24879.751202487743;24921.252362429157;35773.64226357807;36023;36052.4592131113;36136.27727445489;37335;28805.42389152247;29175.270618233866;29304.853475732485;29418;29933.550996735503;31900.521492177173;32117.51823722599;32410.675893240765;32590.02229933011;32933.83533082415;33165.668343316254;33314;34245.65754342425;37761.62238377691;38526.229475410895;31168.53247201339;32426.675733243308;32462;32485.675143248263;32506.187345316557;24757.16089519895;24840.875795620905;24869.507829530285;24906.626400603644;24916.12793552217 09:27:05 INFO - PROCESS | 29820 | |2;jquery.html;366.4100797715677;366.4558131175205;369.4642767986419;376.8379596773388;384.15869246350474;16527.586810329733;16663.66672666546;17453.82546174538;17459.214335354907;17486.562835929108;15672.216389180552;15901.443449479271;16654.16729163543;16705.331786728515;16730.66538669226;5021.899562008767;5168.457311982244;5177.016366890279;5205.750619851227;5213.635045546814;3679.337719210541;5200.531952124308;5744.16709577111;6043.365446628107;6078.939210607904;6093.542984276175;6100.72546735398;6118.663473508956;6131.8773624527485;6184.165137706397;4922.80308787648;5212.035773381917;5214.869628259267;5254.7635356409055;5265.4997775211295;4954.9594585137165;5096.159133742965;5156.767945442464;5176.456472070454;5199.766010529497;11540.192186546945;11668.066554675606;11751.88248117525;11770.41147942608;11865.881341186563;1868.4301288107122;1941.0585865855048;1948.9902550487157;1970.5270735023635;1988.7016947457853;8580;8897.599608017656;9081.318901082444;9202.539873006323;9365.672201472917;1641.564985278902;1677.2033284189913;1679.4289941419854;1736.2187015842921;1772.4062439082923;64510;66267;67605.32394676088;67828;68483.31516684819;8436.915630843736;8853.778655533662;9947.303688741718;9953.80092398148;10153.4923253837;13651.590452286448;13719.039667223398;13735.931320343534;13789.24159171235;13791.172529648253;6947.548409353376;7019.754308599175;7129.89305160423;7216.3505284524645;7310.049693539912;6848.863022739517;6890.276520965327;6897.3447522485285;7001.754938577125;7038.612876291853;4233.491980962304;4244.681648876285;4268.658507319407;4322.200392927319;4323.156984388077;1654.925528351227;1681.8065922418834;1700.3708627807791;1775.6626241014167;1801.369520667782;796.5300472721007;831.3224721851672;837.6146972392646;925.5326060339486;934.3228904117126;13573.389197486136;16005.519834404753;16263.674726505404;16456.753148702777;16469.094199818886;832.3050253038659;842.928351090152;842.9452085614538;850.5492089192737;860.1312674199104;5553.861153471114;9082.727518174466;9095.045020272908;9133.954330228305;9487.288453366025;402401;410554;418075;422641;425738;67549.32450675529;69317;70639.64680176669;71233;71686;894.1460904835997;903.2322525853103;914.6661468563926;975.9024097590184;977.2524019125375;15057;15199.696006079595;15285;15522.37910483568;15807.36770529166;32989.83505082459;36590.63409365872;37287.81356093202;37306.81346593249;37474;40348;48771;50586.747066264434;50617.46912654426;51061.23408148955;7089.0784198053925;7129.643517823984;7158.928410715826;7259.12890453149;7278.708851645875;11281;11896.524139034342;12028.097892658261;12066.939665301617;12191.329476878856;10002.499875006366;10050.346727462691;10284.794304114026;10372.688819335432;10422.739431514272;10086.8486972694;10513.211509136998;10535.57857685684;10617;10655.627053053106;9609.711708648752;10457.424841633783;10597.4701264938;10662.680119596425;10858.022777950022;7746.457747957815;7820.3743700504965;7873.724419645514;7981.441299109239;8008.719694810654;10338.741531461774;10382.961703829556;10463.319884207502;10585.629502967668;10651.786964260516 09:27:05 INFO - PROCESS | 29820 | |3;mootools.html;1229.4836168809102;1261.224347026579;1318.8219590355302;1705.3860610180334;1719.8882072665267;6877.89683154753;7531.209223031585;7603.619819009055;7920.247576480232;8013;7695.769126926187;7916;7946.205379462051;7955.0453945526615;7981.161977992314;2135.4341099608578;2161.3191844568987;2168.945776355588;2170.413988223179;2171.0989939175224;2110.968335474969;2158.740951085872;2177.346795961213;2194.670799380098;2199.6480563109903;2205.151016858505;2211.1155537784934;2224.0992398078724;2226.677131815886;2232.330300909721;2076.211039804872;2083.229205194088;2086.3010891351414;2086.728725265721;2091.7699053104225;2116.8729876207476;2118.7245658064353;2137.7969092936146;2141.903614337343;2163.8052575268302;7539.886901696479;7557.508761930457;7560.206178351304;7571.469997100206;7598.962005189994;4409.779511024468;4564.155631208204;4569.543045695437;4582.725036497821;4585;2919.3139612191117;2971.36115735118;3030;3036.6963303669677;3084.4602194616077;886.3706768194589;924.7410724997012;932.6922115701802;936.7143021378477;947.3747326764302;10524.947375263151;10591.470426478645;10668.839967400496;10680.305780124267;10730.463476826128;4149.8962525937095;4206.72656277341;4281.400603915455;4290.914181716348;4323.978380108079;9081;9103.90896091044;9128.132827381389;9135.314851386172;9155.81688366229;4555.567221113989;4561.657875659339;4586.77066146698;4588.655850811202;4602.677812553089;3544.096255454894;4058.2086493133556;4206.621404073648;4209.116085621992;4216.241076606179;3532.5760908691122;3587.1570181007964;3590.8563657453933;3594.0835087053156;3632.055665526982;1164.8427462292652;1165.2775279326872;1175.5356634129641;1178.6699724077273;1184.6150001249628;675.9623977194982;682.4267615203253;705.0481849503233;717.8169566760442;725.2167658928345;4905.607551395879;5162.819301324435;5163.66436181647;5175.327207463006;5185.2999845021195;395.66566251517423;396.4528950048914;401.40792331311667;415.5325259083531;425.1093958157655;3389.694927456541;3403.829808509565;3424.7431442641405;3440.2947395783804;3455.3089382123676;9283.978762336137;9388.90611093894;9625.903740962642;9650.90349096514;9669.516524173903;9531.237500999903;9549.331546791658;9608.519574021271;9608.855867161998;9663.758406039906;7115.53749006313;7139.39315158207;7302.123745150509;7311.561306321638;7324.926750732531;4626.1904166771355;4736.289556566542;4769.594584460221;4779.450363208275;4806.399200099988;8435.451695639764;8763.518006509703;8830.42602230853;8875.866861996947;8996.50519221449;9054.864177037218;9105.77235569116;9238.30712696537;9265.814683706423;9287.396319239499;6067.757289708362;6870.587764734132;6916;7063.540869843444;7128.536645118051;7124.251953544803;7362;7395.519291246052;7402.000729901394;7417.962910185631;6647.7008534617025;6806.217285012287;6884.48366372514;6889.517733758789;6956;6586.703598338182;6587.934120658732;6708.6981085850275;6766.05275261454;6829.89755153683;5924.11138329254;5964.135200396005;6109.419605137505;6136.29432615255;6136.723847426966;4259.531451540266;4280.529141794463;4382.758948257876;4387.319965405367;4462.576055274743;4316.0073183167415;4337.7831108443825;4371.650267978618;4401.273789824643;4438.489573699066 09:27:05 INFO - PROCESS | 29820 | |4;prototype.html;295.2029520295203;299.40717379588415;300.241889229695;304.0771259228243;304.3653981448681;5073.822416215424;5101.285819985205;5103.183490641498;5104.336436263286;5129.41011783645;4989.251612258154;4994;5009.874753131165;5011.749412529377;5028.793089658483;3717.6839968602635;3791.4502397152396;3903.49254596902;3912.2175564886993;3925.744826586277;3921.2354440501745;3925.1168487090317;3935.685145188378;3946.861859834906;3952.367621180612;3857.729958902878;3882.6311500407414;3894.55212650546;3903.9024024399473;3921.098147426094;3807.809609519513;3886.3587508061137;3897.707671924617;3911.8630847920326;3926.4306675532175;3405.1316914186973;3416.6241713411505;3428.45144776837;3438.1090400279745;3465.6361082086523;4824.421069471686;4832.535406942449;4841.3222148899185;4856.538628830255;4865.732384718839;4377.868663940087;4506.616937560311;4510.21071312519;4521.140983213212;4527.728336299832;5198.882240318312;5200.791968321262;5201.609879259071;5211.680802043093;5214.4524824893215;3712.480252764615;3737.5328083989502;3744.101415660249;3744.5319335083113;3757.6993840492696;5401.459854014606;5506.339239291271;5511.338639363262;5536.446355364431;5538.864532770773;3767.6624798196244;3778.2065766188857;3779.829907654107;3785.962140378561;3786;3810.599887011879;3827.7129215308964;3834.194819087967;3836.0793409582056;3853.614638536124;4398.406215160976;4419.260058763587;4432.468103827497;4441.7569127591005;4444.3333499974615;5120.974395128001;5245.632805703641;5254.395744489356;5294.338207724035;5312.043832110257;1364.6285483089432;1371.6845125621162;1372.1492674541848;1376.167418711685;1377.2906952919254;848.9108643592334;856.5759948825371;895.2524641923936;901.5086777706166;908.3505293715026;4432.534583868712;4522.954770452319;4540.818367265339;4554.111948170142;4585.28928016158;5370.624056316098;5380.139177731544;5402.567794576503;5420.34955805298;5422.295101636762;4437.933430998538;4502.977485112553;4543.954560454419;4551.817927282872;4557.088582283556;2888.422315536859;2888.7000849617757;2888.7111288871365;2889.2343528964843;2890;5025.9644843838305;5033.295338652591;5045.2432135180015;5060.165072763027;5063.721325403583;5283.630145889751;5545.279113715191;5552.361478429952;5559.24950131727;5661.943380566142;5051.6716413433005;5072.6702764320935;5073.771680274396;5076.416212135578;5084.237364395222;5375.5162035417;5503.587230957614;5520.1443776214755;5532.778688852401;5533.695646739468;5164.586833053271;5318.202269659582;5348.117560602457;5373.2746079278795;5391.973040134774;5003.299538064601;5013;5018.4981501849525;5033.974830125826;5100.194892809014;3838.8272527736876;3843.365844635604;3858.401947698111;3868.226354729122;3882.6699730523223;5338.396582307005;5507.642003269774;5525.171224316385;5528.778848846162;5572.164175373727;5256.237845512455;5267.657602255841;5275.155975044128;5306.575473962151;5316.548093412103;5177.896442071213;5271.525562699376;5274.156135018378;5280.260763493037;5326.387465441524;4881.658283920092;5186.481351864783;5195.350581177353;5198.16829307309;5206.609504287269;5090;5162.328897243335;5286.36563612369;5296;5325.147976323769;5153.45888681683;5188.455212202664;5202.8959420812125;5203.531682148625;5204.505571970657 09:27:05 INFO - PROCESS | 29820 | |5;yui.html;601.2754630670044;630.5145038320493;666.1772710702285;716.133870350965;728.9575906453769;12072.154949153562;12151.453184606691;12493.750124997494;12724.745505089893;12972.545960891372;12476.189047711892;12568.057395695314;12576.496940122406;12618.81071783924;12628.873711262908;531.9973400132994;576.3458474631282;621.6891554222889;773.2963003666664;786.8622990976556;787.6534324897027;788.3850596534712;790.3598085550723;791.1574173505198;791.9841603167933;824.8886400335938;826.0211649195692;826.4462809917339;828.7886588919818;829.9377546683993;816.7917181118836;817.452306954342;817.811903262247;818.2594751749676;819.5041999590252;601.5999360425312;602.0367412140583;605.5458406195354;605.8394525450759;606.1846816032429;12794.232346059172;12799.680007999781;12803.743925121445;12817;12830.80753788694;12886;13017;13068.738625227537;13164.14433061848;13386.330683465787;10309.278350515468;10386.688399348031;10493.108085812715;10566.735831604272;10593.788124237471;3330;3333.866645334184;3350.949735753966;3377.4427219508752;3412.419888618916;57290.713546432;57742.7112864433;57829;58593;59244;10161.796764064826;10206.469029645612;10407.63573274947;10417.531211095518;10567.63013294531;19395.709064364044;19646.901765491366;19666.901665491867;19714.309999149962;19715.901420493094;6784.151981002375;6825.215100263434;6879.071325371011;6929.064576282238;7024.754133605299;3622.9818850905576;3665.3585622515952;3677.4667673187237;3680.871169509054;3722.3858063419775;2786.080593404172;2909;2914.1403286030672;2915.3440475892753;2919.459899918522;491.36368402917594;498.5338708307744;503.1170296130341;505.84824552634063;526.9841904742864;464.1876715747442;476.8235752771497;559.9780400768614;579.9768009279582;597.4563147535722;7691.461597688108;7865.488743231672;7943.086545047394;8010.239027292398;8273.8345233095;497.931935997291;542.6255883440414;547.9506844383944;561.1974875927382;564.4750382144645;3648.5986541480415;3678.6137455567314;3716.7212459065677;3721.2371463850386;3839.8080095995088;58663;58930.11604825931;78905.60547197227;99192.50403747935;103934;24031.759682403303;24126.39684007879;24202.273931782074;37679.81160094237;86037;70069.64965175244;74429.25570744331;74859;75215.62392188114;75273.99999999891;7265.418766498773;7298.4891057625455;7302.123745150616;7561.09266887977;7591.810204744705;45096;46243.53756462527;46586.301205481264;46746.53253467422;47577.28634070561;59554.70222648859;65273.347266526725;66461;67012.664936675;69007;9968.850467243143;10232.539535720762;10450.947745261225;10532.473376331305;10714.357138571711;10545.57817687284;11031.448427578749;11415.828762568402;11423.143264255048;11698.824517632413;10849.67450976472;10902.18233632465;11075.833862491907;11773.293602383885;11790.410479476164;12462.813057803958;12670.87329126697;12685.492580297054;12830.29433381173;12857.292848893027;11461.48423320936;11560.13299002595;11910.166288359731;12484;12740.872591273968;9721.416714997124;9723.611055557982;9843.114119729258;9863.704088877059;10099.495025248561;9871.259655526008;9972.252081093802;10148.340357876714;10221.540030698488;10329.793404132026 09:27:05 INFO - PROCESS | 29820 | __end_tp_report 09:27:05 INFO - PROCESS | 29820 | __start_cc_report 09:27:05 INFO - PROCESS | 29820 | _x_x_mozilla_cycle_collect,398 09:27:05 INFO - PROCESS | 29820 | __end_cc_report 09:27:05 INFO - PROCESS | 29820 | __startTimestamp1465316825006__endTimestamp 09:27:05 INFO - PROCESS | 29820 | 09:27:05 INFO - PROCESS | 29820 | ------- Summary: start ------- 09:27:05 INFO - PROCESS | 29820 | Number of tests: 6 09:27:05 INFO - PROCESS | 29820 | 09:27:05 INFO - PROCESS | 29820 | [#0] dojo.html Cycles:165 Average:4835.06 Median:4964.28 stddev:520.18 (10.5%) stddev-sans-first:492.81 09:27:05 INFO - PROCESS | 29820 | Values: 2653.2 2711.3 2713.2 2734.6 2735.0 4795.3 4829.8 4869.6 4929.4 4986.9 4836.3 4847.0 4904.8 4934.8 4936.2 4389.6 4410.0 4494.3 4548.4 4550.9 4229.3 4581.7 4634.1 4641.3 4674.9 4398.8 4434.3 4465.7 4484.8 4545.7 4446.7 4458.7 4471.2 4472.2 4491.3 4399.1 4440.7 4464.1 4468.6 4485.8 4687.4 4761.8 4806.4 4815.2 4847.3 5186.0 5215.1 5224.8 5248.8 5263.7 5240.0 5273.2 5289.7 5290.6 5311.7 4920.6 4961.3 4964.3 4971.8 5017.8 5431.6 5433.4 5444.8 5448.0 5450.0 5037.9 5106.5 5129.4 5153.3 5158.5 5133.7 5232.6 5261.9 5262.3 5263.8 5151.2 5195.6 5214.5 5223.8 5233.4 5076.2 5104.1 5125.8 5209.8 5231.6 4429.0 4457.5 4463.8 4489.9 4490.8 3825.3 3864.6 3876.3 3900.6 3913.1 4416.3 4448.0 4470.7 4474.0 4521.4 5266.6 5286.0 5302.5 5321.5 5326.5 4474.1 4485.9 4488.3 4489.9 4541.8 4631.2 4755.8 4777.4 4784.1 4844.4 4893.1 4904.5 4939.6 4946.5 4990.3 5355.4 5379.9 5381.8 5399.0 5436.8 4722.3 4808.9 4837.7 4938.9 4943.3 5190.4 5192.6 5195.2 5225.5 5230.2 5270.8 5283.4 5311.5 5311.7 5373.0 4921.9 5070.4 5080.1 5091.2 5113.7 4917.5 4983.2 4997.3 5067.2 5074.1 4968.2 5001.4 5001.8 5013.4 5023.3 4973.8 5074.9 5098.8 5110.8 5119.9 5005.8 5043.7 5054.5 5066.0 5121.8 09:27:05 INFO - PROCESS | 29820 | 09:27:05 INFO - PROCESS | 29820 | [#1] ext.html Cycles:180 Average:44981.65 Median:33365.25 stddev:85333.61 (255.8%) stddev-sans-first:85507.83 09:27:05 INFO - PROCESS | 29820 | Values: 565.1 583.3 587.1 598.0 605.2 29858.0 33265.5 33285.5 33409.7 33514.7 37363.8 37619.1 37830.0 37860.0 38138.2 7603.7 7767.0 7800.6 7801.6 7805.3 7716.7 7764.8 7780.8 7789.5 7816.1 7704.4 7757.3 7789.8 7815.7 7823.6 7769.3 7771.5 7795.9 7800.5 7811.9 7635.9 7721.8 7726.0 7735.3 7780.1 35344.8 35813.0 35945.1 35970.5 36044.3 2696.6 2782.8 2807.4 2868.9 2931.4 28141.0 28296.3 28329.4 28345.1 28697.1 3472.8 3521.6 3542.7 3624.3 3628.1 185868.0 186515.0 186797.0 187262.0 187512.0 50203.7 50632.7 50642.0 50746.0 50775.7 32563.3 33200.8 33320.8 35108.0 52995.0 14478.9 14562.0 14645.7 14687.0 14735.2 11234.5 11293.8 11311.8 11339.9 11394.4 17920.5 17933.6 17978.6 18087.4 18099.7 6693.3 6930.2 7016.3 7074.0 7138.9 840.7 939.4 975.3 985.2 1031.1 26174.3 27246.6 27308.9 27527.7 27735.7 980.9 994.1 994.8 1041.9 1055.1 14079.2 14586.4 14644.7 14713.5 14903.2 407109.0 408554.0 413077.0 414523.0 415779.0 45497.8 46681.5 46736.3 47104.5 47218.5 1139.8 1246.6 1254.5 1257.3 1269.6 25601.0 26382.6 26514.5 26751.2 26787.2 40844.4 41128.0 41391.6 41653.2 41819.6 325332.0 325479.0 327279.0 328931.0 329485.0 22361.4 24389.5 24627.5 24879.8 24921.3 35773.6 36023.0 36052.5 36136.3 37335.0 28805.4 29175.3 29304.9 29418.0 29933.6 31900.5 32117.5 32410.7 32590.0 32933.8 33165.7 33314.0 34245.7 37761.6 38526.2 31168.5 32426.7 32462.0 32485.7 32506.2 24757.2 24840.9 24869.5 24906.6 24916.1 09:27:05 INFO - PROCESS | 29820 | 09:27:05 INFO - PROCESS | 29820 | [#2] jquery.html Cycles:180 Average:24354.19 Median:4322.68 stddev:68365.95 (1581.6%) stddev-sans-first:68534.01 09:27:05 INFO - PROCESS | 29820 | Values: 366.4 366.5 369.5 376.8 384.2 16527.6 16663.7 17453.8 17459.2 17486.6 15672.2 15901.4 16654.2 16705.3 16730.7 5021.9 5168.5 5177.0 5205.8 5213.6 3679.3 5200.5 5744.2 6043.4 6078.9 6093.5 6100.7 6118.7 6131.9 6184.2 4922.8 5212.0 5214.9 5254.8 5265.5 4955.0 5096.2 5156.8 5176.5 5199.8 11540.2 11668.1 11751.9 11770.4 11865.9 1868.4 1941.1 1949.0 1970.5 1988.7 8580.0 8897.6 9081.3 9202.5 9365.7 1641.6 1677.2 1679.4 1736.2 1772.4 64510.0 66267.0 67605.3 67828.0 68483.3 8436.9 8853.8 9947.3 9953.8 10153.5 13651.6 13719.0 13735.9 13789.2 13791.2 6947.5 7019.8 7129.9 7216.4 7310.0 6848.9 6890.3 6897.3 7001.8 7038.6 4233.5 4244.7 4268.7 4322.2 4323.2 1654.9 1681.8 1700.4 1775.7 1801.4 796.5 831.3 837.6 925.5 934.3 13573.4 16005.5 16263.7 16456.8 16469.1 832.3 842.9 842.9 850.5 860.1 5553.9 9082.7 9095.0 9134.0 9487.3 402401.0 410554.0 418075.0 422641.0 425738.0 67549.3 69317.0 70639.6 71233.0 71686.0 894.1 903.2 914.7 975.9 977.3 15057.0 15199.7 15285.0 15522.4 15807.4 32989.8 36590.6 37287.8 37306.8 37474.0 40348.0 48771.0 50586.7 50617.5 51061.2 7089.1 7129.6 7158.9 7259.1 7278.7 11281.0 11896.5 12028.1 12066.9 12191.3 10002.5 10050.3 10284.8 10372.7 10422.7 10086.8 10513.2 10535.6 10617.0 10655.6 9609.7 10457.4 10597.5 10662.7 10858.0 7746.5 7820.4 7873.7 7981.4 8008.7 10338.7 10383.0 10463.3 10585.6 10651.8 09:27:05 INFO - PROCESS | 29820 | 09:27:05 INFO - PROCESS | 29820 | [#3] mootools.html Cycles:180 Average:5064.65 Median:4681.24 stddev:2897.65 (61.9%) stddev-sans-first:2891.45 09:27:05 INFO - PROCESS | 29820 | Values: 1229.5 1261.2 1318.8 1705.4 1719.9 6877.9 7531.2 7603.6 7920.2 8013.0 7695.8 7916.0 7946.2 7955.0 7981.2 2135.4 2161.3 2168.9 2170.4 2171.1 2111.0 2158.7 2177.3 2194.7 2199.6 2205.2 2211.1 2224.1 2226.7 2232.3 2076.2 2083.2 2086.3 2086.7 2091.8 2116.9 2118.7 2137.8 2141.9 2163.8 7539.9 7557.5 7560.2 7571.5 7599.0 4409.8 4564.2 4569.5 4582.7 4585.0 2919.3 2971.4 3030.0 3036.7 3084.5 886.4 924.7 932.7 936.7 947.4 10524.9 10591.5 10668.8 10680.3 10730.5 4149.9 4206.7 4281.4 4290.9 4324.0 9081.0 9103.9 9128.1 9135.3 9155.8 4555.6 4561.7 4586.8 4588.7 4602.7 3544.1 4058.2 4206.6 4209.1 4216.2 3532.6 3587.2 3590.9 3594.1 3632.1 1164.8 1165.3 1175.5 1178.7 1184.6 676.0 682.4 705.0 717.8 725.2 4905.6 5162.8 5163.7 5175.3 5185.3 395.7 396.5 401.4 415.5 425.1 3389.7 3403.8 3424.7 3440.3 3455.3 9284.0 9388.9 9625.9 9650.9 9669.5 9531.2 9549.3 9608.5 9608.9 9663.8 7115.5 7139.4 7302.1 7311.6 7324.9 4626.2 4736.3 4769.6 4779.5 4806.4 8435.5 8763.5 8830.4 8875.9 8996.5 9054.9 9105.8 9238.3 9265.8 9287.4 6067.8 6870.6 6916.0 7063.5 7128.5 7124.3 7362.0 7395.5 7402.0 7418.0 6647.7 6806.2 6884.5 6889.5 6956.0 6586.7 6587.9 6708.7 6766.1 6829.9 5924.1 5964.1 6109.4 6136.3 6136.7 4259.5 4280.5 4382.8 4387.3 4462.6 4316.0 4337.8 4371.7 4401.3 4438.5 09:27:05 INFO - PROCESS | 29820 | 09:27:05 INFO - PROCESS | 29820 | [#4] prototype.html Cycles:180 Average:4361.06 Median:5012.37 stddev:1271.71 (25.4%) stddev-sans-first:1238.12 09:27:05 INFO - PROCESS | 29820 | Values: 295.2 299.4 300.2 304.1 304.4 5073.8 5101.3 5103.2 5104.3 5129.4 4989.3 4994.0 5009.9 5011.7 5028.8 3717.7 3791.5 3903.5 3912.2 3925.7 3921.2 3925.1 3935.7 3946.9 3952.4 3857.7 3882.6 3894.6 3903.9 3921.1 3807.8 3886.4 3897.7 3911.9 3926.4 3405.1 3416.6 3428.5 3438.1 3465.6 4824.4 4832.5 4841.3 4856.5 4865.7 4377.9 4506.6 4510.2 4521.1 4527.7 5198.9 5200.8 5201.6 5211.7 5214.5 3712.5 3737.5 3744.1 3744.5 3757.7 5401.5 5506.3 5511.3 5536.4 5538.9 3767.7 3778.2 3779.8 3786.0 3786.0 3810.6 3827.7 3834.2 3836.1 3853.6 4398.4 4419.3 4432.5 4441.8 4444.3 5121.0 5245.6 5254.4 5294.3 5312.0 1364.6 1371.7 1372.1 1376.2 1377.3 848.9 856.6 895.3 901.5 908.4 4432.5 4523.0 4540.8 4554.1 4585.3 5370.6 5380.1 5402.6 5420.3 5422.3 4437.9 4503.0 4544.0 4551.8 4557.1 2888.4 2888.7 2888.7 2889.2 2890.0 5026.0 5033.3 5045.2 5060.2 5063.7 5283.6 5545.3 5552.4 5559.2 5661.9 5051.7 5072.7 5073.8 5076.4 5084.2 5375.5 5503.6 5520.1 5532.8 5533.7 5164.6 5318.2 5348.1 5373.3 5392.0 5003.3 5013.0 5018.5 5034.0 5100.2 3838.8 3843.4 3858.4 3868.2 3882.7 5338.4 5507.6 5525.2 5528.8 5572.2 5256.2 5267.7 5275.2 5306.6 5316.5 5177.9 5271.5 5274.2 5280.3 5326.4 4881.7 5186.5 5195.4 5198.2 5206.6 5090.0 5162.3 5286.4 5296.0 5325.1 5153.5 5188.5 5202.9 5203.5 5204.5 09:27:05 INFO - PROCESS | 29820 | 09:27:05 INFO - PROCESS | 29820 | [#5] yui.html Cycles:180 Average:15944.38 Median:23525.24 stddev:22022.80 (93.6%) stddev-sans-first:22054.45 09:27:05 INFO - PROCESS | 29820 | Values: 601.3 630.5 666.2 716.1 729.0 12072.2 12151.5 12493.8 12724.7 12972.5 12476.2 12568.1 12576.5 12618.8 12628.9 532.0 576.3 621.7 773.3 786.9 787.7 788.4 790.4 791.2 792.0 824.9 826.0 826.4 828.8 829.9 816.8 817.5 817.8 818.3 819.5 601.6 602.0 605.5 605.8 606.2 12794.2 12799.7 12803.7 12817.0 12830.8 12886.0 13017.0 13068.7 13164.1 13386.3 10309.3 10386.7 10493.1 10566.7 10593.8 3330.0 3333.9 3350.9 3377.4 3412.4 57290.7 57742.7 57829.0 58593.0 59244.0 10161.8 10206.5 10407.6 10417.5 10567.6 19395.7 19646.9 19666.9 19714.3 19715.9 6784.2 6825.2 6879.1 6929.1 7024.8 3623.0 3665.4 3677.5 3680.9 3722.4 2786.1 2909.0 2914.1 2915.3 2919.5 491.4 498.5 503.1 505.8 527.0 464.2 476.8 560.0 580.0 597.5 7691.5 7865.5 7943.1 8010.2 8273.8 497.9 542.6 548.0 561.2 564.5 3648.6 3678.6 3716.7 3721.2 3839.8 58663.0 58930.1 78905.6 99192.5 103934.0 24031.8 24126.4 24202.3 37679.8 86037.0 70069.6 74429.3 74859.0 75215.6 75274.0 7265.4 7298.5 7302.1 7561.1 7591.8 45096.0 46243.5 46586.3 46746.5 47577.3 59554.7 65273.3 66461.0 67012.7 69007.0 9968.9 10232.5 10450.9 10532.5 10714.4 10545.6 11031.4 11415.8 11423.1 11698.8 10849.7 10902.2 11075.8 11773.3 11790.4 12462.8 12670.9 12685.5 12830.3 12857.3 11461.5 11560.1 11910.2 12484.0 12740.9 9721.4 9723.6 9843.1 9863.7 10099.5 9871.3 9972.3 10148.3 10221.5 10329.8 09:27:05 INFO - PROCESS | 29820 | -------- Summary: end -------- 09:27:05 INFO - PROCESS | 29820 | 09:27:05 INFO - TEST-INFO | 29820: exit 0 09:27:05 INFO - TEST-OK | dromaeo_css | took 1116340ms 09:27:05 INFO - TEST-START | kraken 09:27:05 INFO - operating with platform_type : linux_ 09:27:05 INFO - Initialising browser for kraken test... 09:27:05 INFO - TEST-INFO | started process 30058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHhoPvP/profile http://localhost:41915/getInfo.html) 09:27:10 INFO - PROCESS | 30058 | __metrics Screen width/height:1600/1200 09:27:10 INFO - PROCESS | 30058 | colorDepth:24 09:27:10 INFO - PROCESS | 30058 | Browser inner width/height: 1024/697 09:27:10 INFO - PROCESS | 30058 | __metrics 09:27:11 ERROR - PROCESS | 30058 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:27:12 INFO - TEST-INFO | 30058: exit 0 09:27:12 INFO - Browser initialized. 09:27:12 INFO - Running cycle 1/1 for kraken test... 09:27:12 INFO - TEST-INFO | started process 30174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHhoPvP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:24 INFO - PROCESS | 30174 | RSS: Main: 168546304 09:27:24 INFO - PROCESS | 30174 | 09:27:27 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-beat-detection) 09:27:27 INFO - PROCESS | 30174 | RSS: Main: 173113344 09:27:27 INFO - PROCESS | 30174 | 09:27:30 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-dft) 09:27:31 INFO - PROCESS | 30174 | RSS: Main: 173187072 09:27:31 INFO - PROCESS | 30174 | 09:27:34 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-fft) 09:27:35 INFO - PROCESS | 30174 | RSS: Main: 167550976 09:27:35 INFO - PROCESS | 30174 | 09:27:37 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-oscillator) 09:27:37 INFO - PROCESS | 30174 | RSS: Main: 168423424 09:27:37 INFO - PROCESS | 30174 | 09:27:40 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41915/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:27:40 INFO - PROCESS | 30174 | RSS: Main: 168808448 09:27:40 INFO - PROCESS | 30174 | 09:27:43 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41915/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:44 INFO - PROCESS | 30174 | RSS: Main: 169246720 09:27:44 INFO - PROCESS | 30174 | 09:27:48 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41915/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:48 INFO - PROCESS | 30174 | RSS: Main: 166404096 09:27:48 INFO - PROCESS | 30174 | 09:27:51 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41915/tests/kraken/driver.html?testName=json-parse-financial) 09:27:52 INFO - PROCESS | 30174 | RSS: Main: 167784448 09:27:52 INFO - PROCESS | 30174 | 09:27:54 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41915/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:54 INFO - PROCESS | 30174 | RSS: Main: 168534016 09:27:54 INFO - PROCESS | 30174 | 09:27:56 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:57 INFO - PROCESS | 30174 | RSS: Main: 168628224 09:27:57 INFO - PROCESS | 30174 | 09:27:59 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:28:00 INFO - PROCESS | 30174 | RSS: Main: 168914944 09:28:00 INFO - PROCESS | 30174 | 09:28:02 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:28:03 INFO - PROCESS | 30174 | RSS: Main: 168857600 09:28:03 INFO - PROCESS | 30174 | 09:28:06 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:28:07 INFO - PROCESS | 30174 | RSS: Main: 168890368 09:28:07 INFO - PROCESS | 30174 | 09:28:08 INFO - PROCESS | 30174 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41915/tests/kraken/driver.html?testName=ai-astar) 09:28:09 INFO - PROCESS | 30174 | RSS: Main: 169447424 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | __start_tp_report 09:28:09 INFO - PROCESS | 30174 | _x_x_mozilla_page_load 09:28:09 INFO - PROCESS | 30174 | _x_x_mozilla_page_load_details 09:28:09 INFO - PROCESS | 30174 | |i|pagename|runs| 09:28:09 INFO - PROCESS | 30174 | |0;ai-astar;116;108;113;117;114;113;113;113;115;114 09:28:09 INFO - PROCESS | 30174 | |1;audio-beat-detection;168;129;165;176;131;158;162;135;179;131 09:28:09 INFO - PROCESS | 30174 | |2;audio-dft;164;164;165;168;169;164;163;163;162;163 09:28:09 INFO - PROCESS | 30174 | |3;audio-fft;77;76;76;173;77;76;79;77;159;77 09:28:09 INFO - PROCESS | 30174 | |4;audio-oscillator;88;88;145;86;86;87;137;88;86;149 09:28:09 INFO - PROCESS | 30174 | |5;imaging-gaussian-blur;117;119;118;118;117;118;117;119;117;117 09:28:09 INFO - PROCESS | 30174 | |6;imaging-darkroom;148;149;147;147;148;148;147;147;147;147 09:28:09 INFO - PROCESS | 30174 | |7;imaging-desaturate;95;96;98;96;97;96;95;95;96;96 09:28:09 INFO - PROCESS | 30174 | |8;json-parse-financial;64;63;66;64;74;65;64;63;63;64 09:28:09 INFO - PROCESS | 30174 | |9;json-stringify-tinderbox;65;65;64;66;66;65;64;66;65;65 09:28:09 INFO - PROCESS | 30174 | |10;stanford-crypto-aes;90;83;84;86;86;86;91;88;111;91 09:28:09 INFO - PROCESS | 30174 | |11;stanford-crypto-ccm;135;142;144;129;141;131;136;150;137;136 09:28:09 INFO - PROCESS | 30174 | |12;stanford-crypto-pbkdf2;177;175;180;171;172;171;173;169;171;176 09:28:09 INFO - PROCESS | 30174 | |13;stanford-crypto-sha256-iterative;71;74;79;72;69;68;70;68;72;70 09:28:09 INFO - PROCESS | 30174 | __end_tp_report 09:28:09 INFO - PROCESS | 30174 | __start_cc_report 09:28:09 INFO - PROCESS | 30174 | _x_x_mozilla_cycle_collect,987 09:28:09 INFO - PROCESS | 30174 | __end_cc_report 09:28:09 INFO - PROCESS | 30174 | __startTimestamp1465316889230__endTimestamp 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | ------- Summary: start ------- 09:28:09 INFO - PROCESS | 30174 | Number of tests: 14 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:2.41 (2.1%) stddev-sans-first:2.40 09:28:09 INFO - PROCESS | 30174 | Values: 116.0 108.0 113.0 117.0 114.0 113.0 113.0 113.0 115.0 114.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:163.50 stddev:19.85 (12.1%) stddev-sans-first:20.34 09:28:09 INFO - PROCESS | 30174 | Values: 168.0 129.0 165.0 176.0 131.0 158.0 162.0 135.0 179.0 131.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.27 (1.4%) stddev-sans-first:2.40 09:28:09 INFO - PROCESS | 30174 | Values: 164.0 164.0 165.0 168.0 169.0 164.0 163.0 163.0 162.0 163.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#3] audio-fft Cycles:10 Average:94.70 Median:77.00 stddev:37.73 (49.0%) stddev-sans-first:39.47 09:28:09 INFO - PROCESS | 30174 | Values: 77.0 76.0 76.0 173.0 77.0 76.0 79.0 77.0 159.0 77.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:86.50 stddev:27.54 (31.8%) stddev-sans-first:28.59 09:28:09 INFO - PROCESS | 30174 | Values: 88.0 88.0 145.0 86.0 86.0 87.0 137.0 88.0 86.0 149.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 09:28:09 INFO - PROCESS | 30174 | Values: 117.0 119.0 118.0 118.0 117.0 118.0 117.0 119.0 117.0 117.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 09:28:09 INFO - PROCESS | 30174 | Values: 148.0 149.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 147.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 09:28:09 INFO - PROCESS | 30174 | Values: 95.0 96.0 98.0 96.0 97.0 96.0 95.0 95.0 96.0 96.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.00 stddev:3.30 (5.2%) stddev-sans-first:3.48 09:28:09 INFO - PROCESS | 30174 | Values: 64.0 63.0 66.0 64.0 74.0 65.0 64.0 63.0 63.0 64.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 09:28:09 INFO - PROCESS | 30174 | Values: 65.0 65.0 64.0 66.0 66.0 65.0 64.0 66.0 65.0 65.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:87.00 stddev:8.02 (9.2%) stddev-sans-first:8.50 09:28:09 INFO - PROCESS | 30174 | Values: 90.0 83.0 84.0 86.0 86.0 86.0 91.0 88.0 111.0 91.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:139.00 stddev:6.26 (4.5%) stddev-sans-first:6.54 09:28:09 INFO - PROCESS | 30174 | Values: 135.0 142.0 144.0 129.0 141.0 131.0 136.0 150.0 137.0 136.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.00 stddev:3.41 (2.0%) stddev-sans-first:3.37 09:28:09 INFO - PROCESS | 30174 | Values: 177.0 175.0 180.0 171.0 172.0 171.0 173.0 169.0 171.0 176.0 09:28:09 INFO - PROCESS | 30174 | 09:28:09 INFO - PROCESS | 30174 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.50 stddev:3.30 (4.6%) stddev-sans-first:3.50 09:28:09 INFO - PROCESS | 30174 | Values: 71.0 74.0 79.0 72.0 69.0 68.0 70.0 68.0 72.0 70.0 09:28:09 INFO - PROCESS | 30174 | -------- Summary: end -------- 09:28:09 INFO - PROCESS | 30174 | 09:28:10 INFO - TEST-INFO | 30174: exit 0 09:28:10 INFO - TEST-OK | kraken | took 64554ms 09:28:10 INFO - SUITE-END | took 1180s 09:28:10 INFO - Completed test suite (00:19:40) 09:28:10 INFO - javascript benchmark 09:28:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6316.522498124364, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.2040387883635, 2711.3492761737175, 2713.1996061161954, 2734.6444962154915, 2734.9863250683743, 4795.280707893813, 4829.806807727691, 4869.586085182759, 4929.433115191754, 4986.875328116799, 4836.3470931424245, 4847.0, 4904.828331008415, 4934.80260789568, 4936.210206366982, 4389.626881715058, 4409.977950110245, 4494.303382975644, 4548.431446069241, 4550.863474095782, 4229.302165142748, 4581.725096494204, 4634.050019745944, 4641.25739881619, 4674.859754207362, 4398.824047038114, 4434.2905135178535, 4465.665075119379, 4484.753338566377, 4545.6802629879985, 4446.710963787344, 4458.7324760514475, 4471.1728330259, 4472.217361961643, 4491.326301054868, 4399.098184872094, 4440.733555986619, 4464.129494748526, 4468.575485328888, 4485.842995495142, 4687.367205427257, 4761.785719642625, 4806.423229212482, 4815.181419158752, 4847.345608342864, 5186.0, 5215.113430716788, 5224.817131400421, 5248.763805628756, 5263.6841789492755, 5240.004399164185, 5273.209018647195, 5289.709066001368, 5290.629655924087, 5311.654742441768, 4920.6309526785635, 4961.255811628249, 4964.280179373971, 4971.751412429364, 5017.82437614689, 5431.5926305526455, 5433.429489903582, 5444.754986025639, 5448.0, 5450.04624190765, 5037.949620503748, 5106.463821298785, 5129.435762066169, 5153.2785410042625, 5158.509941555546, 5133.666311689803, 5232.633715639869, 5261.947380526222, 5262.2632831403635, 5263.815766448156, 5151.150060240094, 5195.558377537876, 5214.504622060898, 5223.817166399158, 5233.4243233244315, 5076.18780995039, 5104.05574968632, 5125.846224613268, 5209.791608335624, 5231.633785634969, 4429.047754732748, 4457.531959144308, 4463.7991290391365, 4489.88775280614, 4490.775461226991, 3825.3496905526126, 3864.555576108727, 3876.2828876657345, 3900.5904380039688, 3913.099987002948, 4416.315471101984, 4447.977760111244, 4470.6870519064005, 4474.038081812426, 4521.367008618796, 5266.631335806534, 5285.973570132125, 5302.522772950376, 5321.547668448148, 5326.467353264643, 4474.0604473060375, 4485.932711009337, 4488.259437192892, 4489.910201795946, 4541.772911354419, 4631.235846085426, 4755.785989630475, 4777.4267087949665, 4784.138855006063, 4844.442889067732, 4893.094777466109, 4904.534069263557, 4939.629527785431, 4946.455889852042, 4990.251462280615, 5355.357357117171, 5379.919301210563, 5381.838544843661, 5398.973005134949, 5436.809711660073, 4722.338872557913, 4808.855734327975, 4837.7097374157665, 4938.901221975612, 4943.283223932582, 5190.40310364313, 5192.610554208525, 5195.220716892496, 5225.451327610698, 5230.215467679878, 5270.762815673381, 5283.392409872914, 5311.548518375981, 5311.654742441729, 5372.973135134299, 4921.926171107365, 5070.41690205631, 5080.136376815876, 5091.185410334477, 5113.7187454688865, 4917.508249175054, 4983.177775666974, 4997.300377947017, 5067.163917953497, 5074.06129865976, 4968.22992436173, 5001.374828146481, 5001.824936127218, 5013.39839219296, 5023.296738456546, 4973.801047958041, 5074.923876141935, 5098.770555324945, 5110.821121260738, 5119.948800512097, 5005.824796132118, 5043.697378157322, 5054.519820617035, 5065.974670126626, 5121.820736274212], "value": 4801.167409708496, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.0930256937615, 583.2592607388617, 587.1134586773971, 597.9850503737406, 605.152786099461, 29858.0, 33265.501017484756, 33285.500717489194, 33409.66590334099, 33514.66485335146, 37363.813180934056, 37619.059523511925, 37830.0, 37860.0, 38138.23723525528, 7603.733869314561, 7766.961165194194, 7800.648970796299, 7801.5709135997495, 7805.258500442449, 7716.6527506262355, 7764.844703105934, 7780.766577002699, 7789.454738168331, 7816.062072551274, 7704.422168337397, 7757.26306000929, 7789.8052548686455, 7815.687372505093, 7823.569703666296, 7769.300762931307, 7771.455998080109, 7795.883061754078, 7800.492967957121, 7811.882821757678, 7635.885461718079, 7721.7683469496005, 7726.0342457192855, 7735.265149810759, 7780.14418413974, 35344.82327588371, 35813.0, 35945.10137246564, 35970.460443093114, 36044.279114417826, 2696.5955106734145, 2782.8052036357462, 2807.4244779820087, 2868.885244590214, 2931.3697555025774, 28141.0, 28296.292592685142, 28329.433411331865, 28345.149645510668, 28697.139085827457, 3472.774269672463, 3521.559805024372, 3542.71658267338, 3624.3476174288617, 3628.147385364464, 185868.0, 186515.0, 186797.0, 187262.0, 187512.0, 50203.748981255594, 50632.746836265585, 50642.0, 50746.0, 50775.746121269156, 32563.348733025206, 33200.83399583035, 33320.833395832866, 35108.0, 52995.0, 14478.85521144796, 14562.0, 14645.707085858223, 14687.0, 14735.189564573837, 11234.49444774987, 11293.774124517628, 11311.773764524663, 11339.94330028361, 11394.37330946806, 17920.462386128438, 17933.551661208574, 17978.64042719138, 18087.36694215696, 18099.72850407245, 6693.330666933268, 6930.168379794457, 7016.298370162943, 7074.045003924404, 7138.857222855514, 840.7183593496125, 939.3706216834737, 975.2782940623887, 985.1724551376877, 1031.138998935882, 26174.34564135912, 27246.5913011305, 27308.859481159525, 27527.724722752515, 27735.72264277372, 980.9313348065709, 994.0953732103751, 994.786120983992, 1041.9322744021615, 1055.1189756553365, 14079.225642589756, 14586.361751762137, 14644.707105857824, 14713.485028023968, 14903.180325082008, 407109.0, 408554.0, 413077.0, 414523.0, 415779.0, 45497.772511137235, 46681.53318466772, 46736.2989555157, 47104.5289547107, 47218.5278147221, 1139.8062329404022, 1246.5637027040464, 1254.4982007197011, 1257.270782945889, 1269.57469247803, 25601.0, 26382.604260935717, 26514.469710605295, 26751.197464076107, 26787.19638410851, 40844.387334189414, 41128.0, 41391.58608413878, 41653.166936661706, 41819.581804181566, 325332.0, 325479.0, 327279.0, 328931.0, 329485.0, 22361.44096397603, 24389.51220975606, 24627.507449851262, 24879.751202487743, 24921.252362429157, 35773.64226357807, 36023.0, 36052.4592131113, 36136.27727445489, 37335.0, 28805.42389152247, 29175.270618233866, 29304.853475732485, 29418.0, 29933.550996735503, 31900.521492177173, 32117.51823722599, 32410.675893240765, 32590.02229933011, 32933.83533082415, 33165.668343316254, 33314.0, 34245.65754342425, 37761.62238377691, 38526.229475410895, 31168.53247201339, 32426.675733243308, 32462.0, 32485.675143248263, 32506.187345316557, 24757.16089519895, 24840.875795620905, 24869.507829530285, 24906.626400603644, 24916.12793552217], "value": 16758.752550437872, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.4100797715677, 366.4558131175205, 369.4642767986419, 376.8379596773388, 384.15869246350474, 16527.586810329733, 16663.66672666546, 17453.82546174538, 17459.214335354907, 17486.562835929108, 15672.216389180552, 15901.443449479271, 16654.16729163543, 16705.331786728515, 16730.66538669226, 5021.899562008767, 5168.457311982244, 5177.016366890279, 5205.750619851227, 5213.635045546814, 3679.337719210541, 5200.531952124308, 5744.16709577111, 6043.365446628107, 6078.939210607904, 6093.542984276175, 6100.72546735398, 6118.663473508956, 6131.8773624527485, 6184.165137706397, 4922.80308787648, 5212.035773381917, 5214.869628259267, 5254.7635356409055, 5265.4997775211295, 4954.9594585137165, 5096.159133742965, 5156.767945442464, 5176.456472070454, 5199.766010529497, 11540.192186546945, 11668.066554675606, 11751.88248117525, 11770.41147942608, 11865.881341186563, 1868.4301288107122, 1941.0585865855048, 1948.9902550487157, 1970.5270735023635, 1988.7016947457853, 8580.0, 8897.599608017656, 9081.318901082444, 9202.539873006323, 9365.672201472917, 1641.564985278902, 1677.2033284189913, 1679.4289941419854, 1736.2187015842921, 1772.4062439082923, 64510.0, 66267.0, 67605.32394676088, 67828.0, 68483.31516684819, 8436.915630843736, 8853.778655533662, 9947.303688741718, 9953.80092398148, 10153.4923253837, 13651.590452286448, 13719.039667223398, 13735.931320343534, 13789.24159171235, 13791.172529648253, 6947.548409353376, 7019.754308599175, 7129.89305160423, 7216.3505284524645, 7310.049693539912, 6848.863022739517, 6890.276520965327, 6897.3447522485285, 7001.754938577125, 7038.612876291853, 4233.491980962304, 4244.681648876285, 4268.658507319407, 4322.200392927319, 4323.156984388077, 1654.925528351227, 1681.8065922418834, 1700.3708627807791, 1775.6626241014167, 1801.369520667782, 796.5300472721007, 831.3224721851672, 837.6146972392646, 925.5326060339486, 934.3228904117126, 13573.389197486136, 16005.519834404753, 16263.674726505404, 16456.753148702777, 16469.094199818886, 832.3050253038659, 842.928351090152, 842.9452085614538, 850.5492089192737, 860.1312674199104, 5553.861153471114, 9082.727518174466, 9095.045020272908, 9133.954330228305, 9487.288453366025, 402401.0, 410554.0, 418075.0, 422641.0, 425738.0, 67549.32450675529, 69317.0, 70639.64680176669, 71233.0, 71686.0, 894.1460904835997, 903.2322525853103, 914.6661468563926, 975.9024097590184, 977.2524019125375, 15057.0, 15199.696006079595, 15285.0, 15522.37910483568, 15807.36770529166, 32989.83505082459, 36590.63409365872, 37287.81356093202, 37306.81346593249, 37474.0, 40348.0, 48771.0, 50586.747066264434, 50617.46912654426, 51061.23408148955, 7089.0784198053925, 7129.643517823984, 7158.928410715826, 7259.12890453149, 7278.708851645875, 11281.0, 11896.524139034342, 12028.097892658261, 12066.939665301617, 12191.329476878856, 10002.499875006366, 10050.346727462691, 10284.794304114026, 10372.688819335432, 10422.739431514272, 10086.8486972694, 10513.211509136998, 10535.57857685684, 10617.0, 10655.627053053106, 9609.711708648752, 10457.424841633783, 10597.4701264938, 10662.680119596425, 10858.022777950022, 7746.457747957815, 7820.3743700504965, 7873.724419645514, 7981.441299109239, 8008.719694810654, 10338.741531461774, 10382.961703829556, 10463.319884207502, 10585.629502967668, 10651.786964260516], "value": 7978.372896359667, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.4836168809102, 1261.224347026579, 1318.8219590355302, 1705.3860610180334, 1719.8882072665267, 6877.89683154753, 7531.209223031585, 7603.619819009055, 7920.247576480232, 8013.0, 7695.769126926187, 7916.0, 7946.205379462051, 7955.0453945526615, 7981.161977992314, 2135.4341099608578, 2161.3191844568987, 2168.945776355588, 2170.413988223179, 2171.0989939175224, 2110.968335474969, 2158.740951085872, 2177.346795961213, 2194.670799380098, 2199.6480563109903, 2205.151016858505, 2211.1155537784934, 2224.0992398078724, 2226.677131815886, 2232.330300909721, 2076.211039804872, 2083.229205194088, 2086.3010891351414, 2086.728725265721, 2091.7699053104225, 2116.8729876207476, 2118.7245658064353, 2137.7969092936146, 2141.903614337343, 2163.8052575268302, 7539.886901696479, 7557.508761930457, 7560.206178351304, 7571.469997100206, 7598.962005189994, 4409.779511024468, 4564.155631208204, 4569.543045695437, 4582.725036497821, 4585.0, 2919.3139612191117, 2971.36115735118, 3030.0, 3036.6963303669677, 3084.4602194616077, 886.3706768194589, 924.7410724997012, 932.6922115701802, 936.7143021378477, 947.3747326764302, 10524.947375263151, 10591.470426478645, 10668.839967400496, 10680.305780124267, 10730.463476826128, 4149.8962525937095, 4206.72656277341, 4281.400603915455, 4290.914181716348, 4323.978380108079, 9081.0, 9103.90896091044, 9128.132827381389, 9135.314851386172, 9155.81688366229, 4555.567221113989, 4561.657875659339, 4586.77066146698, 4588.655850811202, 4602.677812553089, 3544.096255454894, 4058.2086493133556, 4206.621404073648, 4209.116085621992, 4216.241076606179, 3532.5760908691122, 3587.1570181007964, 3590.8563657453933, 3594.0835087053156, 3632.055665526982, 1164.8427462292652, 1165.2775279326872, 1175.5356634129641, 1178.6699724077273, 1184.6150001249628, 675.9623977194982, 682.4267615203253, 705.0481849503233, 717.8169566760442, 725.2167658928345, 4905.607551395879, 5162.819301324435, 5163.66436181647, 5175.327207463006, 5185.2999845021195, 395.66566251517423, 396.4528950048914, 401.40792331311667, 415.5325259083531, 425.1093958157655, 3389.694927456541, 3403.829808509565, 3424.7431442641405, 3440.2947395783804, 3455.3089382123676, 9283.978762336137, 9388.90611093894, 9625.903740962642, 9650.90349096514, 9669.516524173903, 9531.237500999903, 9549.331546791658, 9608.519574021271, 9608.855867161998, 9663.758406039906, 7115.53749006313, 7139.39315158207, 7302.123745150509, 7311.561306321638, 7324.926750732531, 4626.1904166771355, 4736.289556566542, 4769.594584460221, 4779.450363208275, 4806.399200099988, 8435.451695639764, 8763.518006509703, 8830.42602230853, 8875.866861996947, 8996.50519221449, 9054.864177037218, 9105.77235569116, 9238.30712696537, 9265.814683706423, 9287.396319239499, 6067.757289708362, 6870.587764734132, 6916.0, 7063.540869843444, 7128.536645118051, 7124.251953544803, 7362.0, 7395.519291246052, 7402.000729901394, 7417.962910185631, 6647.7008534617025, 6806.217285012287, 6884.48366372514, 6889.517733758789, 6956.0, 6586.703598338182, 6587.934120658732, 6708.6981085850275, 6766.05275261454, 6829.89755153683, 5924.11138329254, 5964.135200396005, 6109.419605137505, 6136.29432615255, 6136.723847426966, 4259.531451540266, 4280.529141794463, 4382.758948257876, 4387.319965405367, 4462.576055274743, 4316.0073183167415, 4337.7831108443825, 4371.650267978618, 4401.273789824643, 4438.489573699066], "value": 3985.63323749303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.2029520295203, 299.40717379588415, 300.241889229695, 304.0771259228243, 304.3653981448681, 5073.822416215424, 5101.285819985205, 5103.183490641498, 5104.336436263286, 5129.41011783645, 4989.251612258154, 4994.0, 5009.874753131165, 5011.749412529377, 5028.793089658483, 3717.6839968602635, 3791.4502397152396, 3903.49254596902, 3912.2175564886993, 3925.744826586277, 3921.2354440501745, 3925.1168487090317, 3935.685145188378, 3946.861859834906, 3952.367621180612, 3857.729958902878, 3882.6311500407414, 3894.55212650546, 3903.9024024399473, 3921.098147426094, 3807.809609519513, 3886.3587508061137, 3897.707671924617, 3911.8630847920326, 3926.4306675532175, 3405.1316914186973, 3416.6241713411505, 3428.45144776837, 3438.1090400279745, 3465.6361082086523, 4824.421069471686, 4832.535406942449, 4841.3222148899185, 4856.538628830255, 4865.732384718839, 4377.868663940087, 4506.616937560311, 4510.21071312519, 4521.140983213212, 4527.728336299832, 5198.882240318312, 5200.791968321262, 5201.609879259071, 5211.680802043093, 5214.4524824893215, 3712.480252764615, 3737.5328083989502, 3744.101415660249, 3744.5319335083113, 3757.6993840492696, 5401.459854014606, 5506.339239291271, 5511.338639363262, 5536.446355364431, 5538.864532770773, 3767.6624798196244, 3778.2065766188857, 3779.829907654107, 3785.962140378561, 3786.0, 3810.599887011879, 3827.7129215308964, 3834.194819087967, 3836.0793409582056, 3853.614638536124, 4398.406215160976, 4419.260058763587, 4432.468103827497, 4441.7569127591005, 4444.3333499974615, 5120.974395128001, 5245.632805703641, 5254.395744489356, 5294.338207724035, 5312.043832110257, 1364.6285483089432, 1371.6845125621162, 1372.1492674541848, 1376.167418711685, 1377.2906952919254, 848.9108643592334, 856.5759948825371, 895.2524641923936, 901.5086777706166, 908.3505293715026, 4432.534583868712, 4522.954770452319, 4540.818367265339, 4554.111948170142, 4585.28928016158, 5370.624056316098, 5380.139177731544, 5402.567794576503, 5420.34955805298, 5422.295101636762, 4437.933430998538, 4502.977485112553, 4543.954560454419, 4551.817927282872, 4557.088582283556, 2888.422315536859, 2888.7000849617757, 2888.7111288871365, 2889.2343528964843, 2890.0, 5025.9644843838305, 5033.295338652591, 5045.2432135180015, 5060.165072763027, 5063.721325403583, 5283.630145889751, 5545.279113715191, 5552.361478429952, 5559.24950131727, 5661.943380566142, 5051.6716413433005, 5072.6702764320935, 5073.771680274396, 5076.416212135578, 5084.237364395222, 5375.5162035417, 5503.587230957614, 5520.1443776214755, 5532.778688852401, 5533.695646739468, 5164.586833053271, 5318.202269659582, 5348.117560602457, 5373.2746079278795, 5391.973040134774, 5003.299538064601, 5013.0, 5018.4981501849525, 5033.974830125826, 5100.194892809014, 3838.8272527736876, 3843.365844635604, 3858.401947698111, 3868.226354729122, 3882.6699730523223, 5338.396582307005, 5507.642003269774, 5525.171224316385, 5528.778848846162, 5572.164175373727, 5256.237845512455, 5267.657602255841, 5275.155975044128, 5306.575473962151, 5316.548093412103, 5177.896442071213, 5271.525562699376, 5274.156135018378, 5280.260763493037, 5326.387465441524, 4881.658283920092, 5186.481351864783, 5195.350581177353, 5198.16829307309, 5206.609504287269, 5090.0, 5162.328897243335, 5286.36563612369, 5296.0, 5325.147976323769, 5153.45888681683, 5188.455212202664, 5202.8959420812125, 5203.531682148625, 5204.505571970657], "value": 3954.6324839713616, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.2754630670044, 630.5145038320493, 666.1772710702285, 716.133870350965, 728.9575906453769, 12072.154949153562, 12151.453184606691, 12493.750124997494, 12724.745505089893, 12972.545960891372, 12476.189047711892, 12568.057395695314, 12576.496940122406, 12618.81071783924, 12628.873711262908, 531.9973400132994, 576.3458474631282, 621.6891554222889, 773.2963003666664, 786.8622990976556, 787.6534324897027, 788.3850596534712, 790.3598085550723, 791.1574173505198, 791.9841603167933, 824.8886400335938, 826.0211649195692, 826.4462809917339, 828.7886588919818, 829.9377546683993, 816.7917181118836, 817.452306954342, 817.811903262247, 818.2594751749676, 819.5041999590252, 601.5999360425312, 602.0367412140583, 605.5458406195354, 605.8394525450759, 606.1846816032429, 12794.232346059172, 12799.680007999781, 12803.743925121445, 12817.0, 12830.80753788694, 12886.0, 13017.0, 13068.738625227537, 13164.14433061848, 13386.330683465787, 10309.278350515468, 10386.688399348031, 10493.108085812715, 10566.735831604272, 10593.788124237471, 3330.0, 3333.866645334184, 3350.949735753966, 3377.4427219508752, 3412.419888618916, 57290.713546432, 57742.7112864433, 57829.0, 58593.0, 59244.0, 10161.796764064826, 10206.469029645612, 10407.63573274947, 10417.531211095518, 10567.63013294531, 19395.709064364044, 19646.901765491366, 19666.901665491867, 19714.309999149962, 19715.901420493094, 6784.151981002375, 6825.215100263434, 6879.071325371011, 6929.064576282238, 7024.754133605299, 3622.9818850905576, 3665.3585622515952, 3677.4667673187237, 3680.871169509054, 3722.3858063419775, 2786.080593404172, 2909.0, 2914.1403286030672, 2915.3440475892753, 2919.459899918522, 491.36368402917594, 498.5338708307744, 503.1170296130341, 505.84824552634063, 526.9841904742864, 464.1876715747442, 476.8235752771497, 559.9780400768614, 579.9768009279582, 597.4563147535722, 7691.461597688108, 7865.488743231672, 7943.086545047394, 8010.239027292398, 8273.8345233095, 497.931935997291, 542.6255883440414, 547.9506844383944, 561.1974875927382, 564.4750382144645, 3648.5986541480415, 3678.6137455567314, 3716.7212459065677, 3721.2371463850386, 3839.8080095995088, 58663.0, 58930.11604825931, 78905.60547197227, 99192.50403747935, 103934.0, 24031.759682403303, 24126.39684007879, 24202.273931782074, 37679.81160094237, 86037.0, 70069.64965175244, 74429.25570744331, 74859.0, 75215.62392188114, 75273.99999999891, 7265.418766498773, 7298.4891057625455, 7302.123745150616, 7561.09266887977, 7591.810204744705, 45096.0, 46243.53756462527, 46586.301205481264, 46746.53253467422, 47577.28634070561, 59554.70222648859, 65273.347266526725, 66461.0, 67012.664936675, 69007.0, 9968.850467243143, 10232.539535720762, 10450.947745261225, 10532.473376331305, 10714.357138571711, 10545.57817687284, 11031.448427578749, 11415.828762568402, 11423.143264255048, 11698.824517632413, 10849.67450976472, 10902.18233632465, 11075.833862491907, 11773.293602383885, 11790.410479476164, 12462.813057803958, 12670.87329126697, 12685.492580297054, 12830.29433381173, 12857.292848893027, 11461.48423320936, 11560.13299002595, 11910.166288359731, 12484.0, 12740.872591273968, 9721.416714997124, 9723.611055557982, 9843.114119729258, 9863.704088877059, 10099.495025248561, 9871.259655526008, 9972.252081093802, 10148.340357876714, 10221.540030698488, 10329.793404132026], "value": 6276.4737577518845, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 113.0, 117.0, 114.0, 113.0, 113.0, 113.0, 115.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 129.0, 165.0, 176.0, 131.0, 158.0, 162.0, 135.0, 179.0, 131.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 168.0, 169.0, 164.0, 163.0, 163.0, 162.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 173.0, 77.0, 76.0, 79.0, 77.0, 159.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 145.0, 86.0, 86.0, 87.0, 137.0, 88.0, 86.0, 149.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 98.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 64.0, 74.0, 65.0, 64.0, 63.0, 63.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 66.0, 65.0, 64.0, 66.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 84.0, 86.0, 86.0, 86.0, 91.0, 88.0, 111.0, 91.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 142.0, 144.0, 129.0, 141.0, 131.0, 136.0, 150.0, 137.0, 136.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 180.0, 171.0, 172.0, 171.0, 173.0, 169.0, 171.0, 176.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 79.0, 72.0, 69.0, 68.0, 70.0, 68.0, 72.0, 70.0], "value": 71.3, "unit": "score"}]}]} 09:28:10 INFO - Return code: 0 09:28:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:28:10 ERROR - # TBPL SUCCESS # 09:28:10 INFO - Running post-action listener: _resource_record_post_action 09:28:10 INFO - ##### 09:28:10 INFO - ##### Finished run-tests step (success) 09:28:10 INFO - ##### 09:28:10 INFO - Running post-run listener: _resource_record_post_run 09:28:10 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 535494656; Read time: 264; Write time: 532456 09:28:10 INFO - TinderboxPrint: CPU usage
13.4% 09:28:10 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 264 09:28:10 INFO - TinderboxPrint: I/O write bytes / time
535,494,656 / 532,456 09:28:10 INFO - TinderboxPrint: CPU idle
8,273.2 (86.5%) 09:28:10 INFO - TinderboxPrint: CPU user
1,228.0 (12.8%) 09:28:10 INFO - TinderboxPrint: Swap in / out
0 / 0 09:28:10 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 237572096; Read time: 0; Write time: 285112 09:28:10 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 12288; Write bytes: 297922560; Read time: 264; Write time: 247344 09:28:11 INFO - Running post-run listener: _upload_blobber_files 09:28:11 INFO - Blob upload gear active. 09:28:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:28:11 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 09:28:11 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:28:11 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:28:11 INFO - (blobuploader) - INFO - Open directory for files ... 09:28:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:28:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:28:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:12 INFO - (blobuploader) - INFO - Done attempting. 09:28:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:28:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:16 INFO - (blobuploader) - INFO - Done attempting. 09:28:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:28:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:28:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:17 INFO - (blobuploader) - INFO - Done attempting. 09:28:17 INFO - (blobuploader) - INFO - Iteration through files over. 09:28:17 INFO - Return code: 0 09:28:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:28:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:28:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d8fe90441723d924d8da903782cc25fdd12b902fa1fd498af4b7fa54429ea2e5521c486ca2597f122b85dedb0b80d54ac6e8b150d542b88014fdb0ab1b0fc30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5fa72770d3c751acce1840491eab36e10fb0dfb8ca7b0676a9e1e36877c7d7d653cc334c2d323172ee5298623387548fcd878c56b83998436da15fde45774ad9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9556a7db9f223bad590f2d3482ab1e890e06cef529023e1301f643d54b111ac35ff2825f3270cf7c0feb26c353de692aa29f3b3096628fe85606141a439e1737"} 09:28:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:28:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:28:17 INFO - Contents: 09:28:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d8fe90441723d924d8da903782cc25fdd12b902fa1fd498af4b7fa54429ea2e5521c486ca2597f122b85dedb0b80d54ac6e8b150d542b88014fdb0ab1b0fc30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5fa72770d3c751acce1840491eab36e10fb0dfb8ca7b0676a9e1e36877c7d7d653cc334c2d323172ee5298623387548fcd878c56b83998436da15fde45774ad9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9556a7db9f223bad590f2d3482ab1e890e06cef529023e1301f643d54b111ac35ff2825f3270cf7c0feb26c353de692aa29f3b3096628fe85606141a439e1737"} 09:28:17 INFO - Running post-run listener: copy_logs_to_upload_dir 09:28:17 INFO - Copying logs to upload dir... 09:28:17 INFO - mkdir: /builds/slave/test/build/upload/logs 09:28:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.445267 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-07 09:28:17.459984) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 09:28:17.463997) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061 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/Firefox-Non-PGO/sha512/9d8fe90441723d924d8da903782cc25fdd12b902fa1fd498af4b7fa54429ea2e5521c486ca2597f122b85dedb0b80d54ac6e8b150d542b88014fdb0ab1b0fc30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5fa72770d3c751acce1840491eab36e10fb0dfb8ca7b0676a9e1e36877c7d7d653cc334c2d323172ee5298623387548fcd878c56b83998436da15fde45774ad9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9556a7db9f223bad590f2d3482ab1e890e06cef529023e1301f643d54b111ac35ff2825f3270cf7c0feb26c353de692aa29f3b3096628fe85606141a439e1737"} build_url:https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/EOqerHXYSJC3BnY9YvY7xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d8fe90441723d924d8da903782cc25fdd12b902fa1fd498af4b7fa54429ea2e5521c486ca2597f122b85dedb0b80d54ac6e8b150d542b88014fdb0ab1b0fc30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5fa72770d3c751acce1840491eab36e10fb0dfb8ca7b0676a9e1e36877c7d7d653cc334c2d323172ee5298623387548fcd878c56b83998436da15fde45774ad9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9556a7db9f223bad590f2d3482ab1e890e06cef529023e1301f643d54b111ac35ff2825f3270cf7c0feb26c353de692aa29f3b3096628fe85606141a439e1737"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 09:28:17.491144) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:28:17.491785) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465315475.652019-1253903061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:28:17.574113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 09:28:17.574754) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 09:28:17.575339) ========= ========= Total master_lag: 0.14 =========