builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1465515851.74 results: success (0) buildid: 20160609160330 builduid: fd8bf0fe69604d2382441f6fb04275da revision: aa163c7e0a7fa740ccfb3735e34d03f09027d6a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:11.740189) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:11.740700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:11.740986) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:11.757179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:11.757560) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 16:44:11-- 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% 71.2M=0s 2016-06-09 16:44:12 (71.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167824 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:11.961540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:11.961884) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.137760 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:12.112350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:12.112720) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aa163c7e0a7fa740ccfb3735e34d03f09027d6a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev aa163c7e0a7fa740ccfb3735e34d03f09027d6a9 --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=a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 16:44:12,274 truncating revision to first 12 chars 2016-06-09 16:44:12,274 Setting DEBUG logging. 2016-06-09 16:44:12,274 attempt 1/10 2016-06-09 16:44:12,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aa163c7e0a7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 16:44:12,717 unpacking tar archive at: fx-team-aa163c7e0a7f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.849242 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:12.976045) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:12.976446) ========= script_repo_revision: aa163c7e0a7fa740ccfb3735e34d03f09027d6a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:12.976872) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:12.977155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:44:12.988747) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-09 16:44:12.989155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:44:13 INFO - MultiFileLogger online at 20160609 16:44:13 in /builds/slave/test 16:44:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:44:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:44:13 INFO - {'append_to_log': False, 16:44:13 INFO - 'base_work_dir': '/builds/slave/test', 16:44:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:44:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:44:13 INFO - 'branch': 'Fx-Team-Non-PGO', 16:44:13 INFO - 'buildbot_json_path': 'buildprops.json', 16:44:13 INFO - 'config_files': ('talos/linux_config.py',), 16:44:13 INFO - 'default_actions': ('clobber', 16:44:13 INFO - 'read-buildbot-config', 16:44:13 INFO - 'download-and-extract', 16:44:13 INFO - 'populate-webroot', 16:44:13 INFO - 'create-virtualenv', 16:44:13 INFO - 'install', 16:44:13 INFO - 'run-tests'), 16:44:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:44:13 INFO - 'download_minidump_stackwalk': True, 16:44:13 INFO - 'download_symbols': 'ondemand', 16:44:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:44:13 INFO - 'tooltool.py': '/tools/tooltool.py', 16:44:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:44:13 INFO - '/tools/misc-python/virtualenv.py')}, 16:44:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:44:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:44:13 INFO - 'installer_path': 'installer.exe', 16:44:13 INFO - 'log_level': 'info', 16:44:13 INFO - 'log_name': 'talos', 16:44:13 INFO - 'log_to_console': True, 16:44:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:44:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:44:13 INFO - 'opt_config_files': (), 16:44:13 INFO - 'pip_index': False, 16:44:13 INFO - 'sps_profile': False, 16:44:13 INFO - 'sps_profile_interval': 0, 16:44:13 INFO - 'suite': 'dromaeojs-e10s', 16:44:13 INFO - 'system_bits': '32', 16:44:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:44:13 INFO - 'title': 'talos-linux64-ix-062', 16:44:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:44:13 INFO - 'use_talos_json': True, 16:44:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:44:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:44:13 INFO - 'work_dir': 'build'} 16:44:13 INFO - ##### 16:44:13 INFO - ##### Running clobber step. 16:44:13 INFO - ##### 16:44:13 INFO - Running pre-action listener: _resource_record_pre_action 16:44:13 INFO - Running main action method: clobber 16:44:13 INFO - rmtree: /builds/slave/test/build 16:44:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:44:20 INFO - Running post-action listener: _resource_record_post_action 16:44:20 INFO - ##### 16:44:20 INFO - ##### Finished clobber step (success) 16:44:20 INFO - ##### 16:44:20 INFO - ##### 16:44:20 INFO - ##### Running read-buildbot-config step. 16:44:20 INFO - ##### 16:44:20 INFO - Running pre-action listener: _resource_record_pre_action 16:44:20 INFO - Running main action method: read_buildbot_config 16:44:20 INFO - Using buildbot properties: 16:44:20 INFO - { 16:44:20 INFO - "project": "", 16:44:20 INFO - "product": "firefox", 16:44:20 INFO - "script_repo_revision": "production", 16:44:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:44:20 INFO - "repository": "", 16:44:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:44:20 INFO - "buildid": "20160609160330", 16:44:20 INFO - "pgo_build": "False", 16:44:20 INFO - "basedir": "/builds/slave/test", 16:44:20 INFO - "buildnumber": 1396, 16:44:20 INFO - "slavename": "talos-linux64-ix-062", 16:44:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:44:20 INFO - "platform": "ubuntu64_hw", 16:44:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:44:20 INFO - "branch": "fx-team", 16:44:20 INFO - "repo_path": "integration/fx-team", 16:44:20 INFO - "revision": "aa163c7e0a7fa740ccfb3735e34d03f09027d6a9", 16:44:20 INFO - "stage_platform": "linux64", 16:44:20 INFO - "builduid": "fd8bf0fe69604d2382441f6fb04275da", 16:44:20 INFO - "slavebuilddir": "test" 16:44:20 INFO - } 16:44:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:44:20 INFO - Running post-action listener: _resource_record_post_action 16:44:20 INFO - ##### 16:44:20 INFO - ##### Finished read-buildbot-config step (success) 16:44:20 INFO - ##### 16:44:20 INFO - ##### 16:44:20 INFO - ##### Running download-and-extract step. 16:44:20 INFO - ##### 16:44:20 INFO - Running pre-action listener: _resource_record_pre_action 16:44:20 INFO - Running main action method: download_and_extract 16:44:20 INFO - mkdir: /builds/slave/test/build/tests 16:44:20 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')]} 16:44:20 INFO - https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:44:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:44:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:44:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/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 16:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/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 16:44:21 INFO - Downloaded 1361 bytes. 16:44:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:44:21 INFO - Using the following test package requirements: 16:44:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:44:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:44:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:44:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:21 INFO - u'jsshell-linux-x86_64.zip'], 16:44:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:44:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:44:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:44:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:44:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:44:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:44:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:21 INFO - https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:44:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:44:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:44:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/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 16:44:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/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 16:44:24 INFO - Downloaded 22879604 bytes. 16:44:24 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'] 16:44:24 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 16:44:26 INFO - Return code: 0 16:44:26 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 16:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:26 INFO - https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:44:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:44:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:44:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/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 16:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/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 16:44:27 INFO - Downloaded 22879604 bytes. 16:44:27 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'] 16:44:27 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 16:44:28 INFO - Return code: 0 16:44: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')]} 16:44:28 INFO - https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/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 16:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/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 16:44:29 INFO - Downloaded 10833377 bytes. 16:44:29 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'] 16:44:29 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 16:44:29 INFO - Return code: 0 16:44:29 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')]} 16:44:29 INFO - https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:44:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:44:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:44:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/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 16:44:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DJ9vfeIZTZissWPsBQgdxw/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 16:44:31 INFO - Downloaded 55371161 bytes. 16:44:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:44:31 INFO - mkdir: /builds/slave/test/properties 16:44:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:44:31 INFO - Writing to file /builds/slave/test/properties/build_url 16:44:31 INFO - Contents: 16:44:31 INFO - build_url:https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:44:31 INFO - Running post-action listener: _resource_record_post_action 16:44:31 INFO - Running post-action listener: set_extra_try_arguments 16:44:31 INFO - ##### 16:44:31 INFO - ##### Finished download-and-extract step (success) 16:44:31 INFO - ##### 16:44:31 INFO - ##### 16:44:31 INFO - ##### Running populate-webroot step. 16:44:31 INFO - ##### 16:44:31 INFO - Running pre-action listener: _resource_record_pre_action 16:44:31 INFO - Running main action method: populate_webroot 16:44:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:44:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:44:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:44:31 INFO - '--tppagecycles', 16:44:31 INFO - '7'], 16:44:31 INFO - 'tests': ['tsvgm']}}, 16:44:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:44:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:44:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:44:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:44:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['damp', 'tps']}, 16:44:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'tests': ['damp', 'tps']}, 16:44:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['dromaeo_dom']}, 16:44:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:44:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'other-e10s': {'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['tsvgx', 16:44:31 INFO - 'tsvgr_opacity', 16:44:31 INFO - 'tart', 16:44:31 INFO - 'tscrollx', 16:44:31 INFO - 'cart']}, 16:44:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:44:31 INFO - 'tsvgr_opacity', 16:44:31 INFO - 'tart', 16:44:31 INFO - 'tscrollx', 16:44:31 INFO - 'cart']}, 16:44:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['tp5o']}, 16:44:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'tests': ['tp5o']}, 16:44:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'talos_options': ['--disable-e10s', 16:44:31 INFO - '--xperf_path', 16:44:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:31 INFO - 'tests': ['tp5n']}, 16:44:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'talos_options': ['--xperf_path', 16:44:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:31 INFO - 'tests': ['tp5n']}}, 16:44:31 INFO - 'talos.zip': {'path': '', 16:44:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:44:31 INFO - Running post-action listener: _resource_record_post_action 16:44:31 INFO - ##### 16:44:31 INFO - ##### Finished populate-webroot step (success) 16:44:31 INFO - ##### 16:44:31 INFO - ##### 16:44:31 INFO - ##### Running create-virtualenv step. 16:44:31 INFO - ##### 16:44:31 INFO - Running pre-action listener: _resource_record_pre_action 16:44:31 INFO - Running main action method: create_virtualenv 16:44:31 INFO - Creating virtualenv /builds/slave/test/build/venv 16:44:31 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 16:44:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:44:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:44:32 INFO - Using real prefix '/usr' 16:44:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:44:33 INFO - Installing distribute.............................................................................................................................................................................................done. 16:44:35 INFO - Installing pip.................done. 16:44:35 INFO - Return code: 0 16:44:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:35 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 0x7f42423a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', '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 16:44:35 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 16:44:35 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 16:44:35 INFO - Using env: {'DISPLAY': ':0', 16:44:35 INFO - 'HOME': '/home/cltbld', 16:44:35 INFO - 'LANG': 'en_US.UTF-8', 16:44:35 INFO - 'LANGUAGE': 'en_US:en', 16:44:35 INFO - 'LOGNAME': 'cltbld', 16:44:35 INFO - 'MAIL': '/var/mail/cltbld', 16:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:35 INFO - 'MOZ_NO_REMOTE': '1', 16:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:35 INFO - 'NO_EM_RESTART': '1', 16:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:35 INFO - 'PWD': '/builds/slave/test', 16:44:35 INFO - 'SHELL': '/bin/bash', 16:44:35 INFO - 'SHLVL': '1', 16:44:35 INFO - 'TERM': 'linux', 16:44:35 INFO - 'TMOUT': '86400', 16:44:35 INFO - 'USER': 'cltbld', 16:44:35 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', 16:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:35 INFO - '_': '/tools/buildbot/bin/python'} 16:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:35 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 16:44:35 INFO - Cleaning up... 16:44:35 INFO - Return code: 0 16:44:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:35 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 0x7f42423a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', '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 16:44:35 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 16:44:35 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 16:44:35 INFO - Using env: {'DISPLAY': ':0', 16:44:35 INFO - 'HOME': '/home/cltbld', 16:44:35 INFO - 'LANG': 'en_US.UTF-8', 16:44:35 INFO - 'LANGUAGE': 'en_US:en', 16:44:35 INFO - 'LOGNAME': 'cltbld', 16:44:35 INFO - 'MAIL': '/var/mail/cltbld', 16:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:35 INFO - 'MOZ_NO_REMOTE': '1', 16:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:35 INFO - 'NO_EM_RESTART': '1', 16:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:35 INFO - 'PWD': '/builds/slave/test', 16:44:35 INFO - 'SHELL': '/bin/bash', 16:44:35 INFO - 'SHLVL': '1', 16:44:35 INFO - 'TERM': 'linux', 16:44:35 INFO - 'TMOUT': '86400', 16:44:35 INFO - 'USER': 'cltbld', 16:44:35 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', 16:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:35 INFO - '_': '/tools/buildbot/bin/python'} 16:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:36 INFO - Downloading/unpacking psutil>=3.1.1 16:44:36 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 16:44:36 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 16:44:36 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 16:44:36 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 16:44:36 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 16:44:36 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 16:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:44:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:38 INFO - Installing collected packages: psutil 16:44:38 INFO - Running setup.py install for psutil 16:44:38 INFO - building 'psutil._psutil_linux' extension 16:44:38 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 16:44:39 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 16:44:39 INFO - building 'psutil._psutil_posix' extension 16:44:39 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 16:44:39 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 16:44:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:39 INFO - Successfully installed psutil 16:44:39 INFO - Cleaning up... 16:44:39 INFO - Return code: 0 16:44:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:39 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 0x7f42423a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', '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 16:44:39 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 16:44:39 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 16:44:39 INFO - Using env: {'DISPLAY': ':0', 16:44:39 INFO - 'HOME': '/home/cltbld', 16:44:39 INFO - 'LANG': 'en_US.UTF-8', 16:44:39 INFO - 'LANGUAGE': 'en_US:en', 16:44:39 INFO - 'LOGNAME': 'cltbld', 16:44:39 INFO - 'MAIL': '/var/mail/cltbld', 16:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:39 INFO - 'MOZ_NO_REMOTE': '1', 16:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:39 INFO - 'NO_EM_RESTART': '1', 16:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:39 INFO - 'PWD': '/builds/slave/test', 16:44:39 INFO - 'SHELL': '/bin/bash', 16:44:39 INFO - 'SHLVL': '1', 16:44:39 INFO - 'TERM': 'linux', 16:44:39 INFO - 'TMOUT': '86400', 16:44:39 INFO - 'USER': 'cltbld', 16:44:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', 16:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:39 INFO - '_': '/tools/buildbot/bin/python'} 16:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:44:40 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 16:44:40 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 16:44:40 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 16:44:40 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 16:44:40 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 16:44:40 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 16:44:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:44:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:44:42 INFO - Installing collected packages: mozsystemmonitor 16:44:42 INFO - Running setup.py install for mozsystemmonitor 16:44:42 INFO - Successfully installed mozsystemmonitor 16:44:42 INFO - Cleaning up... 16:44:42 INFO - Return code: 0 16:44:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42423a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', '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 16:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:44:42 INFO - Using env: {'DISPLAY': ':0', 16:44:42 INFO - 'HOME': '/home/cltbld', 16:44:42 INFO - 'LANG': 'en_US.UTF-8', 16:44:42 INFO - 'LANGUAGE': 'en_US:en', 16:44:42 INFO - 'LOGNAME': 'cltbld', 16:44:42 INFO - 'MAIL': '/var/mail/cltbld', 16:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:42 INFO - 'MOZ_NO_REMOTE': '1', 16:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:42 INFO - 'NO_EM_RESTART': '1', 16:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:42 INFO - 'PWD': '/builds/slave/test', 16:44:42 INFO - 'SHELL': '/bin/bash', 16:44:42 INFO - 'SHLVL': '1', 16:44:42 INFO - 'TERM': 'linux', 16:44:42 INFO - 'TMOUT': '86400', 16:44:42 INFO - 'USER': 'cltbld', 16:44:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', 16:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:42 INFO - '_': '/tools/buildbot/bin/python'} 16:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:42 INFO - Downloading/unpacking jsonschema==2.5.1 16:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:44:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:44 INFO - Downloading functools32-3.2.3-2.tar.gz 16:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:44:44 INFO - warning: no files found matching '*.txt' 16:44:44 INFO - no previously-included directories found matching 'build' 16:44:44 INFO - no previously-included directories found matching 'dist' 16:44:44 INFO - no previously-included directories found matching '.git*' 16:44:44 INFO - Installing collected packages: jsonschema, functools32 16:44:44 INFO - Running setup.py install for functools32 16:44:44 INFO - warning: no files found matching '*.txt' 16:44:44 INFO - no previously-included directories found matching 'build' 16:44:44 INFO - no previously-included directories found matching 'dist' 16:44:44 INFO - no previously-included directories found matching '.git*' 16:44:44 INFO - Successfully installed jsonschema functools32 16:44:44 INFO - Cleaning up... 16:44:44 INFO - Return code: 0 16:44:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:44 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 0x7f42423a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', '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 16:44:44 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 16:44:44 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 16:44:44 INFO - Using env: {'DISPLAY': ':0', 16:44:44 INFO - 'HOME': '/home/cltbld', 16:44:44 INFO - 'LANG': 'en_US.UTF-8', 16:44:44 INFO - 'LANGUAGE': 'en_US:en', 16:44:44 INFO - 'LOGNAME': 'cltbld', 16:44:44 INFO - 'MAIL': '/var/mail/cltbld', 16:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:44 INFO - 'MOZ_NO_REMOTE': '1', 16:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:44 INFO - 'NO_EM_RESTART': '1', 16:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:44 INFO - 'PWD': '/builds/slave/test', 16:44:44 INFO - 'SHELL': '/bin/bash', 16:44:44 INFO - 'SHLVL': '1', 16:44:44 INFO - 'TERM': 'linux', 16:44:44 INFO - 'TMOUT': '86400', 16:44:44 INFO - 'USER': 'cltbld', 16:44:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', 16:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:44 INFO - '_': '/tools/buildbot/bin/python'} 16:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:44 INFO - Downloading/unpacking blobuploader==1.2.4 16:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:46 INFO - Downloading blobuploader-1.2.4.tar.gz 16:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:44:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:44:46 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 16:44:46 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 16:44:46 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 16:44:46 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 16:44:46 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 16:44:46 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 16:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:44:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:47 INFO - Downloading docopt-0.6.1.tar.gz 16:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:44:47 INFO - Installing collected packages: blobuploader, requests, docopt 16:44:47 INFO - Running setup.py install for blobuploader 16:44:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:44:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:44:47 INFO - Running setup.py install for requests 16:44:48 INFO - Running setup.py install for docopt 16:44:48 INFO - Successfully installed blobuploader requests docopt 16:44:48 INFO - Cleaning up... 16:44:48 INFO - Return code: 0 16:44:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:48 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')]} 16:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:48 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')]} 16:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:48 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 0x7f42423a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', '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 16:44:48 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 16:44:48 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 16:44:48 INFO - Using env: {'DISPLAY': ':0', 16:44:48 INFO - 'HOME': '/home/cltbld', 16:44:48 INFO - 'LANG': 'en_US.UTF-8', 16:44:48 INFO - 'LANGUAGE': 'en_US:en', 16:44:48 INFO - 'LOGNAME': 'cltbld', 16:44:48 INFO - 'MAIL': '/var/mail/cltbld', 16:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:48 INFO - 'MOZ_NO_REMOTE': '1', 16:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:48 INFO - 'NO_EM_RESTART': '1', 16:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:48 INFO - 'PWD': '/builds/slave/test', 16:44:48 INFO - 'SHELL': '/bin/bash', 16:44:48 INFO - 'SHLVL': '1', 16:44:48 INFO - 'TERM': 'linux', 16:44:48 INFO - 'TMOUT': '86400', 16:44:48 INFO - 'USER': 'cltbld', 16:44:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', 16:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:48 INFO - '_': '/tools/buildbot/bin/python'} 16:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:48 INFO - Running setup.py (path:/tmp/pip-1s9bAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:48 INFO - Running setup.py (path:/tmp/pip-7IC7K6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:48 INFO - Running setup.py (path:/tmp/pip-yxLmoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:48 INFO - Running setup.py (path:/tmp/pip-xdutDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:48 INFO - Running setup.py (path:/tmp/pip-qqaxEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:48 INFO - Running setup.py (path:/tmp/pip-ZehPnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:48 INFO - Running setup.py (path:/tmp/pip-UsiGo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:48 INFO - Running setup.py (path:/tmp/pip-GHKLIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:49 INFO - Running setup.py (path:/tmp/pip-oMGhfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:49 INFO - Running setup.py (path:/tmp/pip-SNsGK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:49 INFO - Running setup.py (path:/tmp/pip-xCi5Nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:49 INFO - Running setup.py (path:/tmp/pip-KcQJsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:49 INFO - Running setup.py (path:/tmp/pip-wCb2lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:49 INFO - Running setup.py (path:/tmp/pip-ialTn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:49 INFO - Running setup.py (path:/tmp/pip-5_yJ3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:49 INFO - Running setup.py (path:/tmp/pip-L8N7K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:49 INFO - Running setup.py (path:/tmp/pip-f8S5GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:44:49 INFO - Running setup.py install for manifestparser 16:44:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:44:49 INFO - Running setup.py install for mozcrash 16:44:49 INFO - Running setup.py install for mozdebug 16:44:50 INFO - Running setup.py install for mozdevice 16:44:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:44:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:44:50 INFO - Running setup.py install for mozfile 16:44:50 INFO - Running setup.py install for mozhttpd 16:44:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:44:50 INFO - Running setup.py install for mozinfo 16:44:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:44:50 INFO - Running setup.py install for mozInstall 16:44:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:44:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:44:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:44:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:44:50 INFO - Running setup.py install for mozleak 16:44:50 INFO - Running setup.py install for mozlog 16:44:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:44:50 INFO - Running setup.py install for moznetwork 16:44:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:44:50 INFO - Running setup.py install for mozprocess 16:44:50 INFO - Running setup.py install for mozprofile 16:44:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:44:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:44:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:44:51 INFO - Running setup.py install for mozrunner 16:44:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:44:51 INFO - Running setup.py install for mozscreenshot 16:44:51 INFO - Running setup.py install for moztest 16:44:51 INFO - Running setup.py install for mozversion 16:44:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:44:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:44:51 INFO - Cleaning up... 16:44:51 INFO - Return code: 0 16:44:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:51 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')]} 16:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:51 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')]} 16:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:51 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 0x7f42423a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', '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 16:44:51 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 16:44:51 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 16:44:51 INFO - Using env: {'DISPLAY': ':0', 16:44:51 INFO - 'HOME': '/home/cltbld', 16:44:51 INFO - 'LANG': 'en_US.UTF-8', 16:44:51 INFO - 'LANGUAGE': 'en_US:en', 16:44:51 INFO - 'LOGNAME': 'cltbld', 16:44:51 INFO - 'MAIL': '/var/mail/cltbld', 16:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:51 INFO - 'MOZ_NO_REMOTE': '1', 16:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:51 INFO - 'NO_EM_RESTART': '1', 16:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:51 INFO - 'PWD': '/builds/slave/test', 16:44:51 INFO - 'SHELL': '/bin/bash', 16:44:51 INFO - 'SHLVL': '1', 16:44:51 INFO - 'TERM': 'linux', 16:44:51 INFO - 'TMOUT': '86400', 16:44:51 INFO - 'USER': 'cltbld', 16:44:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', 16:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:51 INFO - '_': '/tools/buildbot/bin/python'} 16:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:51 INFO - Running setup.py (path:/tmp/pip-hakW9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:51 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)) 16:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:51 INFO - Running setup.py (path:/tmp/pip-tgbTxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:51 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)) 16:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:51 INFO - Running setup.py (path:/tmp/pip-ve7y6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:51 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)) 16:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:51 INFO - Running setup.py (path:/tmp/pip-KL8DAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:52 INFO - Running setup.py (path:/tmp/pip-w5NLs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:52 INFO - Running setup.py (path:/tmp/pip-iNpTKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:52 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)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:52 INFO - Running setup.py (path:/tmp/pip-rrakwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:52 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)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:52 INFO - Running setup.py (path:/tmp/pip-PUxNId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:52 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)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:52 INFO - Running setup.py (path:/tmp/pip-4rygDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:52 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)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:52 INFO - Running setup.py (path:/tmp/pip-vFOlcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:52 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)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:52 INFO - Running setup.py (path:/tmp/pip-3D6qsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:52 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)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:52 INFO - Running setup.py (path:/tmp/pip-LG1TAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:52 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)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:52 INFO - Running setup.py (path:/tmp/pip-T_wTk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:52 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)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:52 INFO - Running setup.py (path:/tmp/pip-aCTAWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:52 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)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:52 INFO - Running setup.py (path:/tmp/pip-fctUIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:52 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)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:52 INFO - Running setup.py (path:/tmp/pip-bnjhtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:52 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)) 16:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:52 INFO - Running setup.py (path:/tmp/pip-w96atQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:52 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)) 16:44:52 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)) 16:44:52 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)) 16:44:52 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)) 16:44:52 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)) 16:44:52 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)) 16:44:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:44:52 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 16:44:52 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 16:44:52 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 16:44:52 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 16:44:52 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 16:44:52 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 16:44:54 INFO - Downloading blessings-1.6.tar.gz 16:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:44:54 INFO - Installing collected packages: blessings 16:44:54 INFO - Running setup.py install for blessings 16:44:55 INFO - Successfully installed blessings 16:44:55 INFO - Cleaning up... 16:44:55 INFO - Return code: 0 16:44:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:44:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:55 INFO - Reading from file tmpfile_stdout 16:44:55 INFO - Current package versions: 16:44:55 INFO - argparse == 1.2.1 16:44:55 INFO - blessings == 1.6 16:44:55 INFO - blobuploader == 1.2.4 16:44:55 INFO - docopt == 0.6.1 16:44:55 INFO - functools32 == 3.2.3-2 16:44:55 INFO - jsonschema == 2.5.1 16:44:55 INFO - manifestparser == 1.1 16:44:55 INFO - mozInstall == 1.12 16:44:55 INFO - mozcrash == 0.17 16:44:55 INFO - mozdebug == 0.1 16:44:55 INFO - mozdevice == 0.48 16:44:55 INFO - mozfile == 1.2 16:44:55 INFO - mozhttpd == 0.7 16:44:55 INFO - mozinfo == 0.9 16:44:55 INFO - mozleak == 0.1 16:44:55 INFO - mozlog == 3.2 16:44:55 INFO - moznetwork == 0.27 16:44:55 INFO - mozprocess == 0.22 16:44:55 INFO - mozprofile == 0.28 16:44:55 INFO - mozrunner == 6.11 16:44:55 INFO - mozscreenshot == 0.1 16:44:55 INFO - mozsystemmonitor == 0.3 16:44:55 INFO - moztest == 0.7 16:44:55 INFO - mozversion == 1.4 16:44:55 INFO - psutil == 3.1.1 16:44:55 INFO - requests == 1.2.3 16:44:55 INFO - wsgiref == 0.1.2 16:44:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:55 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 0x7f42423a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', '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 16:44:55 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 16:44:55 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 16:44:55 INFO - Using env: {'DISPLAY': ':0', 16:44:55 INFO - 'HOME': '/home/cltbld', 16:44:55 INFO - 'LANG': 'en_US.UTF-8', 16:44:55 INFO - 'LANGUAGE': 'en_US:en', 16:44:55 INFO - 'LOGNAME': 'cltbld', 16:44:55 INFO - 'MAIL': '/var/mail/cltbld', 16:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:55 INFO - 'MOZ_NO_REMOTE': '1', 16:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:55 INFO - 'NO_EM_RESTART': '1', 16:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:55 INFO - 'PWD': '/builds/slave/test', 16:44:55 INFO - 'SHELL': '/bin/bash', 16:44:55 INFO - 'SHLVL': '1', 16:44:55 INFO - 'TERM': 'linux', 16:44:55 INFO - 'TMOUT': '86400', 16:44:55 INFO - 'USER': 'cltbld', 16:44:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', 16:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:55 INFO - '_': '/tools/buildbot/bin/python'} 16:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:55 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)) 16:44:55 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)) 16:44:55 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)) 16:44:55 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)) 16:44:55 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)) 16:44:55 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)) 16:44:55 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)) 16:44:55 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)) 16:44:55 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)) 16:44:55 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)) 16:44:55 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)) 16:44:55 INFO - Cleaning up... 16:44:55 INFO - Return code: 0 16:44:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42423a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', '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 16:44: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'] in /builds/slave/test/build 16:44: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 16:44:55 INFO - Using env: {'DISPLAY': ':0', 16:44:55 INFO - 'HOME': '/home/cltbld', 16:44:55 INFO - 'LANG': 'en_US.UTF-8', 16:44:55 INFO - 'LANGUAGE': 'en_US:en', 16:44:55 INFO - 'LOGNAME': 'cltbld', 16:44:55 INFO - 'MAIL': '/var/mail/cltbld', 16:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:55 INFO - 'MOZ_NO_REMOTE': '1', 16:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:55 INFO - 'NO_EM_RESTART': '1', 16:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:55 INFO - 'PWD': '/builds/slave/test', 16:44:55 INFO - 'SHELL': '/bin/bash', 16:44:55 INFO - 'SHLVL': '1', 16:44:55 INFO - 'TERM': 'linux', 16:44:55 INFO - 'TMOUT': '86400', 16:44:55 INFO - 'USER': 'cltbld', 16:44:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', 16:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:55 INFO - '_': '/tools/buildbot/bin/python'} 16:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:44:55 INFO - Cleaning up... 16:44:55 INFO - Return code: 0 16:44:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42423a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', '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 16:44: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', 'flake8'] in /builds/slave/test/build 16:44: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 flake8 16:44:55 INFO - Using env: {'DISPLAY': ':0', 16:44:55 INFO - 'HOME': '/home/cltbld', 16:44:55 INFO - 'LANG': 'en_US.UTF-8', 16:44:55 INFO - 'LANGUAGE': 'en_US:en', 16:44:55 INFO - 'LOGNAME': 'cltbld', 16:44:55 INFO - 'MAIL': '/var/mail/cltbld', 16:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:55 INFO - 'MOZ_NO_REMOTE': '1', 16:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:55 INFO - 'NO_EM_RESTART': '1', 16:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:55 INFO - 'PWD': '/builds/slave/test', 16:44:55 INFO - 'SHELL': '/bin/bash', 16:44:55 INFO - 'SHLVL': '1', 16:44:55 INFO - 'TERM': 'linux', 16:44:55 INFO - 'TMOUT': '86400', 16:44:55 INFO - 'USER': 'cltbld', 16:44:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', 16:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:55 INFO - '_': '/tools/buildbot/bin/python'} 16:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:56 INFO - Downloading/unpacking flake8 16:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:44:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:44:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:44:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:44:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:44:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:44:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:44:58 INFO - no previously-included directories found matching 'docs/_build' 16:44:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:44:58 INFO - Running setup.py install for pep8 16:44:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:44:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:44:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:44:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:44:58 INFO - no previously-included directories found matching 'docs/_build' 16:44:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:44:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:44:58 INFO - Cleaning up... 16:44:58 INFO - Return code: 0 16:44:58 INFO - Running post-action listener: _resource_record_post_action 16:44:58 INFO - Running post-action listener: _start_resource_monitoring 16:44:58 INFO - Starting resource monitoring. 16:44:58 INFO - ##### 16:44:58 INFO - ##### Finished create-virtualenv step (success) 16:44:58 INFO - ##### 16:44:58 INFO - ##### 16:44:58 INFO - ##### Running install step. 16:44:58 INFO - ##### 16:44:58 INFO - Running pre-action listener: _resource_record_pre_action 16:44:58 INFO - Running main action method: install 16:44:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:59 INFO - Reading from file tmpfile_stdout 16:44:59 INFO - Detecting whether we're running mozinstall >=1.0... 16:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:44:59 INFO - Reading from file tmpfile_stdout 16:44:59 INFO - Output received: 16:44:59 INFO - Usage: mozinstall [options] installer 16:44:59 INFO - Options: 16:44:59 INFO - -h, --help show this help message and exit 16:44:59 INFO - -d DEST, --destination=DEST 16:44:59 INFO - Directory to install application into. [default: 16:44:59 INFO - "/builds/slave/test"] 16:44:59 INFO - --app=APP Application being installed. [default: firefox] 16:44:59 INFO - mkdir: /builds/slave/test/build/application 16:44:59 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'] 16:44:59 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 16:45:15 INFO - Reading from file tmpfile_stdout 16:45:15 INFO - Output received: 16:45:15 INFO - /builds/slave/test/build/application/firefox/firefox 16:45:15 INFO - Running post-action listener: _resource_record_post_action 16:45:15 INFO - ##### 16:45:15 INFO - ##### Finished install step (success) 16:45:15 INFO - ##### 16:45:15 INFO - ##### 16:45:15 INFO - ##### Running run-tests step. 16:45:15 INFO - ##### 16:45:15 INFO - Running pre-action listener: _resource_record_pre_action 16:45:15 INFO - Running main action method: run_tests 16:45:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:45:15 INFO - Python 2.7.3 16:45:15 INFO - Return code: 0 16:45:15 INFO - grabbing minidump binary from tooltool 16:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:45:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:45:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:45:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:45:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:45:15 INFO - Return code: 0 16:45:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:45:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:45:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:45:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:45:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:45:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:45:16 INFO - Return code: 0 16:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 16:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 16:45:16 INFO - Using env: {'DISPLAY': ':0', 16:45:16 INFO - 'HOME': '/home/cltbld', 16:45:16 INFO - 'LANG': 'en_US.UTF-8', 16:45:16 INFO - 'LANGUAGE': 'en_US:en', 16:45:16 INFO - 'LOGNAME': 'cltbld', 16:45:16 INFO - 'MAIL': '/var/mail/cltbld', 16:45:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:45:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:16 INFO - 'MOZ_NO_REMOTE': '1', 16:45:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:16 INFO - 'NO_EM_RESTART': '1', 16:45:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:16 INFO - 'PWD': '/builds/slave/test', 16:45:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:45:16 INFO - 'SHELL': '/bin/bash', 16:45:16 INFO - 'SHLVL': '1', 16:45:16 INFO - 'TERM': 'linux', 16:45:16 INFO - 'TMOUT': '86400', 16:45:16 INFO - 'USER': 'cltbld', 16:45:16 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991', 16:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:16 INFO - '_': '/tools/buildbot/bin/python'} 16:45:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 16:45:16 INFO - mozversion application_buildid: 20160609160330 16:45:16 INFO - mozversion application_changeset: aa163c7e0a7fa740ccfb3735e34d03f09027d6a9 16:45:16 INFO - mozversion application_display_name: Nightly 16:45:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:45:16 INFO - mozversion application_name: Firefox 16:45:16 INFO - mozversion application_remotingname: firefox 16:45:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:45:16 INFO - mozversion application_vendor: Mozilla 16:45:16 INFO - mozversion application_version: 50.0a1 16:45:16 INFO - mozversion platform_buildid: 20160609160330 16:45:16 INFO - mozversion platform_changeset: aa163c7e0a7fa740ccfb3735e34d03f09027d6a9 16:45:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:45:16 INFO - mozversion platform_version: 50.0a1 16:45:16 INFO - using testdate: 1465515916 16:45:16 INFO - actual date: 1465515916 16:45:16 INFO - starting webserver on 'localhost:50124' 16:45:16 INFO - SUITE-START | Running 2 tests 16:45:16 INFO - TEST-START | dromaeo_css 16:45:16 INFO - operating with platform_type : linux_ 16:45:16 INFO - Initialising browser for dromaeo_css test... 16:45:16 INFO - TEST-INFO | started process 3356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf7wSOL/profile http://localhost:50124/getInfo.html) 16:45:23 INFO - PROCESS | 3356 | __metrics Screen width/height:1600/1200 16:45:23 INFO - PROCESS | 3356 | colorDepth:24 16:45:23 INFO - PROCESS | 3356 | Browser inner width/height: 1024/697 16:45:23 INFO - PROCESS | 3356 | __metrics 16:45:24 ERROR - PROCESS | 3356 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 16:45:25 INFO - TEST-INFO | 3356: exit 0 16:45:25 INFO - Browser initialized. 16:45:25 INFO - Running cycle 1/1 for dromaeo_css test... 16:45:25 INFO - TEST-INFO | started process 3476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf7wSOL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:37 INFO - PROCESS | 3476 | RSS: Main: 185671680 16:45:37 INFO - PROCESS | 3476 | 16:46:27 INFO - PROCESS | 3476 | 1465515987377 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] 16:48:38 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:50124/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50124/tests/dromaeo/cssquery-ext.html) 16:48:40 INFO - PROCESS | 3476 | RSS: Main: 188362752 16:48:40 INFO - PROCESS | 3476 | 16:51:42 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:50124/tests/dromaeo/cssquery-ext.html (next: http://localhost:50124/tests/dromaeo/cssquery-jquery.html) 16:51:42 INFO - PROCESS | 3476 | RSS: Main: 187752448 16:51:42 INFO - PROCESS | 3476 | 16:54:44 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:50124/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50124/tests/dromaeo/cssquery-mootools.html) 16:54:45 INFO - PROCESS | 3476 | RSS: Main: 188854272 16:54:45 INFO - PROCESS | 3476 | 16:57:47 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:50124/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50124/tests/dromaeo/cssquery-prototype.html) 16:57:47 INFO - PROCESS | 3476 | RSS: Main: 186458112 16:57:47 INFO - PROCESS | 3476 | 17:00:50 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:50124/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50124/tests/dromaeo/cssquery-yui.html) 17:00:51 INFO - PROCESS | 3476 | RSS: Main: 188600320 17:00:51 INFO - PROCESS | 3476 | 17:03:53 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:50124/tests/dromaeo/cssquery-yui.html (next: http://localhost:50124/tests/dromaeo/cssquery-dojo.html) 17:03:53 INFO - PROCESS | 3476 | RSS: Main: 189702144 17:03:53 INFO - PROCESS | 3476 | 17:03:53 INFO - PROCESS | 3476 | __start_tp_report 17:03:53 INFO - PROCESS | 3476 | _x_x_mozilla_page_load 17:03:53 INFO - PROCESS | 3476 | _x_x_mozilla_page_load_details 17:03:53 INFO - PROCESS | 3476 | |i|pagename|runs| 17:03:53 INFO - PROCESS | 3476 | |0;dojo.html;2532.139072715277;2615.992842755539;2626.3959289363434;2630.6448629435044;2637.6307316975626;4671.672982891195;4710.434747830261;4744.07490539345;4747.477777444478;4813.133635945528;4602.746848923308;4722.102800467908;4757.215059515176;4757.33397324374;4764.618830493561;4285.2929266671035;4326.567343265664;4396.494403143647;4419.558044195571;4445.1331990261915;4072.4139474954095;4408.3167109097985;4441.888952776174;4443.200223959686;4448.844290449835;4130.318497447917;4231.090315582134;4278.101598664253;4383;4451.465824101128;4312.805923733408;4317.244482215599;4327.221100201962;4329.19909816685;4366.08312254427;4304.913901721948;4357.433533640607;4362.629176519999;4365;4388.846390376321;4677.74272415017;4703.459102203256;4718.598919091882;4719.362886010379;4755.453122890843;5031.823886164003;5044.672096313765;5066.797328106872;5067.898642027176;5108.055009823194;4922.1386257405165;5067.341245638044;5103.668261562986;5107.974460127675;5145.228215767627;4717.9292310615365;4726.976365118152;4757.8096876125255;4763.785629646674;4764.380630518011;5219.556337711337;5234;5248.055350036953;5255.395629502656;5291.391489978625;4979.502049795064;4982.451930287665;5018.397792264952;5028;5031.421386540522;5040.2691609716385;5125.461826508163;5143.305653736773;5154.149565321755;5193.37679478465;4779.139754844092;4952.281919121707;4967.850964471072;5004.899902001939;5032.396112466454;4862.270659401118;4931.334269873593;4941.085899108676;4955.4548999610015;4999.325091112653;4216.367544868233;4218.535961044283;4224.5353011168745;4272.700910936204;4273.658107351466;3683.723720720957;3719.683826874692;3760.398336266239;3777.8299976500575;3792.981035094807;4277.850275240352;4452.844150454784;4474.798634061475;4492.483364413069;4498.145352383102;5138.614603904647;5150.793968241303;5156.226566015052;5170.638055336166;5185.533302002837;4484.148011877798;4497.145542346943;4502.212112880233;4506.481754598198;4584.862454126382;4332.653387728974;4521.909561808746;4530.977345113253;4542.091581683677;4584.426946631671;4836.347093142381;4878.390201224847;4879.73161476108;4881.51184881509;4940.1601727706375;4980.626453016111;5168.224766285088;5175.948240517697;5177.948220517897;5221.034108689904;4790.281457781361;4811.037792441596;4837.056773929191;4839.612830973584;4847.3698419205275;5003.249512572997;5035.974820125876;5037.5214354636255;5042.8814753026445;5110.284560161655;4786.827227329327;5081.618878584047;5105.387353517602;5109.514596113363;5116.897662046813;4705.623550115914;4792.856214313576;4906.607471402351;4971.328870602422;5053.84838454847;4967.776450059684;4967.850964471072;4984.152694041949;5006.949930500648;5031.84904452867;4845;4859.562639362474;4879;4906.313116163668;4947.381577302837;4768.618510519081;4928.162212423825;4984.077945580079;4984.878402359585;4984.928240428325;4895.04546613407;4909.4354149273295;4915.950840491692;4920.434150072788;4961.7271050092595 17:03:53 INFO - PROCESS | 3476 | |1;ext.html;574.4772257245904;574.967932561053;576.167438052015;585.6251998720819;597.4801922327575;34882.47676284854;38212.42681359782;38301.23397532048;38337.233255334875;38350.616493835056;38460;38466.8076659617;38554.22891542168;38983.80508097463;39002.41496377557;7527.096748390187;7635.923640763604;7662.578558179298;7691.461597688164;7745.419093567977;7523.6614352354;7632.6183690815515;7652.57910814905;7711.074671039483;7729.381649468029;7675.462717609769;7683.692652293929;7709.344705700022;7728.6522106505345;7754.3796496280165;7614.695412183533;7656.464047516676;7700.268474494942;7727.227277272228;7743.535387876689;7583.544987300779;7657.387409007266;7666.425018123663;7687.192844751333;7689.231076892322;37237.25525489475;37549.62450375489;37621.24757504834;37777.62222377796;38011.239775204616;2666.6933302670245;2733.098077634376;2838.3471801485566;2979.687132851041;3330;29491.85254073716;29565.40869182626;29889.25276868074;29922.850385747934;29965.400691986255;2917.7519910807396;2961.3633068890076;2988.3276262840905;3016.5173572228337;3022.319978004953;244445;244554;245140;247603;247760;31397.8430107848;32433.67566324354;50767.23849142266;51098.48901511011;51163.74418127885;33723.662763372544;33758.831205844304;33846.49230261548;33909.66090339065;34012.82993585016;13778.931105344409;13886;13921.58235252944;13970.580882573538;13972;11521.53913843437;11534.480948357344;11556.76886462266;11682.766344673058;11774.05807535395;7750.263724946121;7773.961130194426;7801.882971755428;7849.21507849222;7886.921130788619;3093.6751641077813;3115.454795410794;3133.4829753090485;3188.681131886839;3190.7128358447853;898.2320116300469;923.3213588012806;943.8112377524523;962.5091203486272;982.577491678585;27080.864595676896;27816;28311.71688283132;28421.289467763472;28694.13917582476;938.4556956964944;958.6405098088217;974.5322245322285;980.7401038724744;1076.4079756134095;13931.651708707363;14324.928375358266;14345.426182952773;14614.707705846036;14769.409223630935;380682;383933;384911;387245;391781;48444.27333589999;49708.502914970384;49791.75104124456;49796.751016244685;50296;1170.7658468306372;1182.266994463438;1203.9819402708965;1205.5659962413524;1206.2460961898637;25745.356366090247;26596.601050983863;27022;27171;27292.31769205786;41268.38097428601;41381;41477.58522414737;41649;42107.10518026635;318969;319890;320886;321511;323712;24867.751322486543;24976.875115625033;25357;25593.744062559137;25646.615300770878;40788.77633670995;41817.58182418137;41987.37018944657;42348.15303693847;42597;36004.819975899954;36124.81937590295;36349;36558.4516232262;36594.45108323324;35027.47458788171;35059;35145.82427087951;35334.116647084025;35752.64247357597;34695.47956780701;34923.30153396969;35375.46936796002;35564.466533001505;35735.46396804102;31455.685443145274;32339.35321293514;32354;32497;32502.51246231261;24581.13966011181;24715;24743.204074811187;25263.242102736946;25319.367015824017 17:03:53 INFO - PROCESS | 3476 | |2;jquery.html;335.10025581314164;348.0845376659386;350.8333541567754;354.92723991581727;366.12130885873916;15879.603009924758;16066.357345706172;16691.83308166918;16706.081165535892;16837.242324095416;16137.575338994422;16340.34638614454;17031.148442577884;17094.914525427386;17161.399351022716;4376.606105450509;4665.790039448233;4668.603168730645;4728.314394412825;4734.431868175824;2902.767778577719;4639.396878405802;5202.8699282518055;5501.119820828668;5508.834734957938;5515.420880807517;5547.362053363874;5564.221009058735;5580.051391263474;5589.636673616202;5395.973020134894;5423.2136340230645;5527.55779537636;5532.723363831833;5533.612647114704;5221.086309895753;5351.625386222966;5367.543758780508;5381.838544843661;5398.433164517708;10816.459177041117;10949.616763413242;10980.066694330992;11128.332300061942;11132.33206007634;1869.9252029918787;1893.422506135628;1920.3278852401688;1949.629570381623;1966.587016726489;8535.573221338971;8576.356773242032;8936.240419564345;9130.680426185118;9215;1460.2552698124034;1461.9561413157621;1471.1761413608306;1484.1466156959684;1553.992230038854;63680;65168.674156629386;67419.66290168568;68749.9999999995;69710.65144674295;9609.558566214984;9801.362911410735;9808.264380171515;9902.257330700226;10136.442495662663;13214.141080829715;13286.933565332112;13377.264250466123;13412.597622071353;13526.59420217395;7342.889856652155;7360.595167265745;7394.001809755721;7451.739189128354;7566.2433756625;7130.893036604455;7228.855422891513;7234.674439650228;7301.269873012762;7361.852762944711;4141.4409054777825;4144.274751918462;4242.066745316026;4279.593438623326;4317.222899878052;1585.9603509912113;1716.1933891071176;1731.619043810385;1766.496548483676;1779.117829116839;825.3191117328229;828.8632375657949;899.3794281945437;912.4023764434306;915.0849150849151;15891.28489217988;16070.598235044217;16200.75698864518;16507;16622.50132496027;812.7886749445187;852.7058164933088;865.6537385045906;904.4256896870403;919.5678031325266;9140.634374625073;9359.204467620328;9402.247820174369;9515.952420237993;9579.13787759105;384112;387427;396645;397551;399781;71476.64261678659;71837.28162718305;72888.63555682187;72912;74449.25550744424;891.362675686887;896.2695403246333;899.2401420799414;926.9073092690677;927.1146055516965;14775.482858099915;14873;14891.851081489047;15174.577875180466;15221.847781522487;35268.47097293491;35572.466413003305;37619.62380376161;37795.81102094472;37986;49334;50069;50394.244086338;50407.24389134093;50620.44416002578;7307.086614173229;7393.112826460859;7573.886391704239;7751.418643601865;7842.451028427955;11774;11782.116341274268;11945.581904633296;11957.282563046245;12097.092718046359;9346.299027573095;10035.448050357301;10133.341332813343;10298.897011029794;10449.738756531147;9754.512274386394;9838.60645574169;10305.330153539995;10370;10718.464076796285;10179.541920613738;10290.742731431774;10519.579216831242;10539.57841686324;10681;7692.307692307719;7705.7688269349765;7764.262395072459;7933.325667318342;7994;9835.459049752333;10266;10346.275760696679;10486.895131048897;10636.787264254826 17:03:53 INFO - PROCESS | 3476 | |3;mootools.html;1385.7159282347122;1401.9649508762284;1468.4052958551783;1638.5657800682814;1639.4999525144826;6536.346365363462;7365.116186057674;7409.296116868903;7867.527948323104;7890.960545197273;7560.659770310335;7714.922850771491;7727.72952946647;7732.613369331525;7780.06639203295;2133.25336132354;2168.1544197762887;2170.218721260345;2171.934841954736;2177.662462318335;2123.766385697572;2124.4582631428966;2152.7309086364203;2165.66432203008;2170.4031391367344;2089.7910208979133;2099.8215151712047;2111.187192930725;2111.6515774897125;2156.148321413041;2053.1376821734907;2062.7937206279325;2064.3703670380605;2073.2225415469197;2081.5004398944297;2048;2091.7908209179113;2101.88600041978;2102.0645812613393;2114.6405111131144;7782.805429864242;7820.178881217504;7848.686052557948;7872.803179920491;7876.684932602689;4311;4410.448693913261;4441.067375851075;4448.777561121963;4477.529859364785;2641.9603705944232;2818.168640251131;2829.858507074638;2830.575413687963;2842.07632519432;913.5204017890594;917.6008436330218;918.8346097702411;937.6811883959418;1574.9291281892342;9968.501574921298;10265.076143147078;10291.53688084038;10381.740456488573;10498.530205771274;3834.6740527054953;3923.803809809498;3959.6238357356006;4060.451839001697;4073.327900896378;8212.137725538852;8257.21556452136;8299.6680132794;8301.169883011771;8326.750987351945;4530.275155975029;4560.996580752229;4572.725636461823;4590.655700822452;4610.7694615269775;3492.895213143559;4040.5555388907196;4090.9590904091174;4094.774787386663;4167.312393455107;3259.6577359377397;3289.309245058517;3369.679880411357;3388.373150967079;3505.2814173094453;989.1641562879355;1004.4927311707687;1006.4263369879098;1007.0332480818496;1009.7980403919246;752.8644843928146;755.2598453515585;776.4836383804819;795.3358945280639;814.3851392198852;4928.67963582366;4928.8767780805765;5136.255242989746;5233.058049551118;5321.6540924839765;372.9813509324523;375.6938095452198;382.5791629207849;384.1855266834329;388.50853670107335;3483.111806489329;3494.3884820156372;3500.807455589916;3518.472229165646;3571.8749843755863;9317.301202409846;9541.093596108358;9660.516974151406;9669.081437263449;9703.272254580794;9299.860502092473;9471.621135154655;9534.332596718303;9547.331686781998;9616.90383096174;7241.89137162943;7261.709531618676;7286;7322.780316590511;7409.814754631069;5144.536991670768;5147.974260128675;5150.433452320167;5178.508041736029;5183.948160518346;8644.789729438009;8859.867101993605;8864.778380540538;8913.37606367574;8991.23574496149;8950.507722075088;8967.69968354598;9043.773905652411;9045.547722613974;9055.81888362216;5531.640443371168;6027.126066720389;6063.272407310975;6135.14108024868;6154.569180157525;6940.826479338057;6998.300169982961;7093.432525398059;7115.501914866117;7127.46544009191;6411.51913606472;6594.241662208908;6640.203175618956;6726.091977582963;6750.932490675031;6413.134226879311;6532.902006470002;6554.377334153248;6581.967090164519;6614.04096406028;5988.550858685703;6002.249718785152;6007.969960150346;6053.880032194058;6065.939340606537;4067.2272268268935;4097.44684467593;4215.831366745296;4233.576642335742;4261.659067274672;4100.425940368291;4228.894277643083;4312.504062032781;4391.912161756683;4424.60178583929 17:03:53 INFO - PROCESS | 3476 | |4;prototype.html;281.6591923772235;286.7533920828089;288.5095337925527;293.31949876287007;293.44978165938863;4959.528844759751;5002.549770520653;5062.898742025157;5094.566961808247;5094.694318340898;4919.409670839495;4941.629377796662;5033.389315419058;5044.545990860822;5078.289039534468;3631.164832088608;3780.924381512368;3846.6345697158795;3870.9225815483674;3900.7074469414765;3835.846566137351;3857.6528112469873;3884.2814079395403;3890.708196885231;3902.434147048676;3851.595582463829;3860.517435320585;3880.3209438348176;3895.2014836958356;3904.258190943726;3806.9619303806885;3859.6526312632;3896.4544963705102;3909.6707119579337;3920.372740361557;3375.6118046424485;3378.4256676365076;3382.3066271414546;3385.1198688340965;3411.1642647551507;4880.219164933629;4906.803727850882;4912.5578697917;4918.90162196754;4942.555170034678;4425.269830477967;4434.733915965053;4449.663926438613;4461.687681862271;4464.263396539567;5065.745743144303;5192.662476938987;5210.322658054467;5233.607479439057;5235.214717792362;3683.226522430293;3699.5375578052744;3729.6083911189207;3733.8879833605033;3738.532683414573;5470.316210473691;5488.231647569303;5503.3395992481155;5514.862128446781;5537.224788529649;3639.3267245559655;3749.8438397921304;3754.342989976743;3761.981190094032;3774.8490060397826;3793.5827059023486;3798.1074447504816;3801.657850793442;3807.162424266712;3808.257389809016;4384.210842048462;4386.806596701649;4387.473503179639;4392.582704643054;4403.889902752393;5056.873578160576;5190.844274671766;5216.634835561475;5218;5234.764435600331;1326.1512631915582;1351.776642138866;1352.1278775189946;1356.911800732969;1357.9001009182593;829.1915382502133;845.678642115992;858.8539948208819;860.7417774667574;869.4565896314804;4472.753998530112;4505.617022553054;4666.160091183551;4712.64655150865;4726.983698504838;5395.298611180521;5470.835874923759;5488.17677348401;5494.395616482184;5520.613557051048;4607.9078418431445;4749.952500474951;4760.214564596872;4790.281457781361;4791.6645834791925;2883.596296518489;2924.546695262238;2944.146197602714;2947.5873377726707;2962.215013021551;5128.692278463304;5159.948400515947;5176.378834539804;5213.56626927598;5213.817516386908;5369.95285919242;5504.972475137599;5509.669419834822;5528.834134975958;5569.637973531708;5099.745012749348;5106.646738614196;5136.589072874236;5138.948610513847;5156.561692256125;5372.597055220952;5384.150332512272;5448.863778405572;5527.3141691782785;5527.723613819373;5069.8732531687;5235.921461178009;5277.577793776411;5287.841364759063;5316.946830531645;5114.207297868837;5118.564921981673;5169.198774190007;5180.818671346485;5191.61185854496;3798.715096367728;3841.500604921454;3848.383678854944;3854.7494412863075;3866.69066474687;5183.429822719422;5363.785448582013;5392.865178370572;5409.350877894678;5414.184623995579;5177.922331165111;5211.609129315392;5232.215167724872;5243.134882744304;5247.501487358695;5125.76981524424;5195.740212989411;5200.2199670049795;5211.9478805212975;5227.928274703752;4881.633877459276;5222.42553319127;5225.660332078555;5243;5277.656952298242;5155.742212889266;5181.896362072813;5341.172118321666;5358.758855851574;5379.4082650907585;5246.501582349671;5250.18622113573;5262.289590905179;5272.630915836008;5286.7795525878455 17:03:53 INFO - PROCESS | 3476 | |5;yui.html;503.16474652077557;513.1609817947655;515.8529819001584;557.5845994733924;583.7664934026391;10914.563417463301;11378.544858205683;11422.371769552672;11429.314241145537;11497.712557186074;11988.100892433058;12232.633021009362;12300.507979680802;12361.072919531049;12417.441215145318;613.1752792494088;753.9660715267826;759.7682706774445;771.6334740998037;774.6088225446169;766.5209244222361;768.4352001279055;768.9461737678365;771.5756334016297;772.8879312499685;819.4878201124297;819.9918000820005;825.6821123867325;828.2545708862042;830.3689196210893;806.3629732511338;812.585581353508;814.9755507334789;816.1104396208102;821.650798410673;595.4254144750337;598.892199404107;601.0713447723234;601.8134378342684;602.6564858030924;12034.51861925522;12128;12143.757124857453;12159.209651372632;12163.331016794073;12058.216215946024;12501;12676.478822541354;12759.489620415172;12899.484020639164;9591.42451452908;9666.226701863834;9810.112421004469;9822.508874556244;9912.801743965152;3249.1877030742316;3315.1712071982006;3351.162209447638;3366.394049071166;3403.9659603404143;56835.71582142104;58571.41428585702;58752;58853.7057314715;59143.70428147875;9430.245580353556;9473.28950328728;9486.383385079947;9551.522423878778;9674;18473.44579662612;18495.630087398178;18591.814081859007;18640.254389824528;18697.53256168607;5897.852553686193;5900.586958912835;6010.759569617167;6027;6171.938280617136;3333.2000319923045;3510.613832478425;3547.8580856765957;3729.4965179700935;3776.735628505978;2773.653293338333;2827.3355761396056;2836.3901761121456;2842.317843717493;2866.956995645067;452.81660927323827;459.60244388603616;505.3809083872227;529.4863981937515;535.7267793425303;454.5182106966626;480.96152307815294;489.9093667671492;499.188818170473;521.7860677122362;6926.896096558556;7099.574025558483;7131.832191015964;7137.82155446118;7299.160596531361;493.30444073855693;521.257208477925;524.7638562646824;530.5702381071344;535.8312131678509;3430.776999495025;3511.701505372021;3517.7889326640484;3530.417481115587;3610.2598967212184;58353.70823145857;94986.57520137203;98103;100582.4970875141;101237.49381253195;51627.48372516227;52188.47811521912;52265;52392.73803630957;52775;48238.758806206446;48466.75766621215;50347.24479132743;72618.63690681619;77691.61154194192;6560.27836937946;6575.572587781779;6655.301193374819;6683.532152749261;6754.831129221809;44142.558574413844;44274.3358849624;45608.54391456043;46020.76989615164;47046;56581.15128272997;57114.42885571258;62139;65901.34098658952;66946.66526667336;8874.245689116497;8915.509646969478;9012.188902998761;9055.501947392957;9070.818583628423;9204.493752843659;9256.861147082664;9508.239340852853;9544.475053872104;10006.499025146286;8407.70573029941;8529.658813647384;8567;8799.34004949644;8946.552672366226;8998.370114091951;9172.541372931193;9230.907690923004;9349.672761453316;9475.194608458083;8223.588820558829;8230.547319897463;8278.503289802631;8570;8649;7305.853882922418;7381.1511676157925;7453.9254607455405;7534.849303014019;7624.923750762421;7763.844723105619;7846.254605812439;7882.763517094496;8119.391045671717;8137.471064380797 17:03:53 INFO - PROCESS | 3476 | __end_tp_report 17:03:53 INFO - PROCESS | 3476 | __start_cc_report 17:03:53 INFO - PROCESS | 3476 | _x_x_mozilla_cycle_collect,386 17:03:53 INFO - PROCESS | 3476 | __end_cc_report 17:03:53 INFO - PROCESS | 3476 | __startTimestamp1465517033746__endTimestamp 17:03:53 INFO - PROCESS | 3476 | 17:03:53 INFO - PROCESS | 3476 | ------- Summary: start ------- 17:03:53 INFO - PROCESS | 3476 | Number of tests: 6 17:03:53 INFO - PROCESS | 3476 | 17:03:53 INFO - PROCESS | 3476 | [#0] dojo.html Cycles:165 Average:4691.32 Median:4836.35 stddev:503.99 (10.4%) stddev-sans-first:476.22 17:03:53 INFO - PROCESS | 3476 | Values: 2532.1 2616.0 2626.4 2630.6 2637.6 4671.7 4710.4 4744.1 4747.5 4813.1 4602.7 4722.1 4757.2 4757.3 4764.6 4285.3 4326.6 4396.5 4419.6 4445.1 4072.4 4408.3 4441.9 4443.2 4448.8 4130.3 4231.1 4278.1 4383.0 4451.5 4312.8 4317.2 4327.2 4329.2 4366.1 4304.9 4357.4 4362.6 4365.0 4388.8 4677.7 4703.5 4718.6 4719.4 4755.5 5031.8 5044.7 5066.8 5067.9 5108.1 4922.1 5067.3 5103.7 5108.0 5145.2 4717.9 4727.0 4757.8 4763.8 4764.4 5219.6 5234.0 5248.1 5255.4 5291.4 4979.5 4982.5 5018.4 5028.0 5031.4 5040.3 5125.5 5143.3 5154.1 5193.4 4779.1 4952.3 4967.9 5004.9 5032.4 4862.3 4931.3 4941.1 4955.5 4999.3 4216.4 4218.5 4224.5 4272.7 4273.7 3683.7 3719.7 3760.4 3777.8 3793.0 4277.9 4452.8 4474.8 4492.5 4498.1 5138.6 5150.8 5156.2 5170.6 5185.5 4484.1 4497.1 4502.2 4506.5 4584.9 4332.7 4521.9 4531.0 4542.1 4584.4 4836.3 4878.4 4879.7 4881.5 4940.2 4980.6 5168.2 5175.9 5177.9 5221.0 4790.3 4811.0 4837.1 4839.6 4847.4 5003.2 5036.0 5037.5 5042.9 5110.3 4786.8 5081.6 5105.4 5109.5 5116.9 4705.6 4792.9 4906.6 4971.3 5053.8 4967.8 4967.9 4984.2 5006.9 5031.8 4845.0 4859.6 4879.0 4906.3 4947.4 4768.6 4928.2 4984.1 4984.9 4984.9 4895.0 4909.4 4916.0 4920.4 4961.7 17:03:53 INFO - PROCESS | 3476 | 17:03:53 INFO - PROCESS | 3476 | [#1] ext.html Cycles:180 Average:45821.75 Median:35469.97 stddev:85141.90 (240.0%) stddev-sans-first:85312.97 17:03:53 INFO - PROCESS | 3476 | Values: 574.5 575.0 576.2 585.6 597.5 34882.5 38212.4 38301.2 38337.2 38350.6 38460.0 38466.8 38554.2 38983.8 39002.4 7527.1 7635.9 7662.6 7691.5 7745.4 7523.7 7632.6 7652.6 7711.1 7729.4 7675.5 7683.7 7709.3 7728.7 7754.4 7614.7 7656.5 7700.3 7727.2 7743.5 7583.5 7657.4 7666.4 7687.2 7689.2 37237.3 37549.6 37621.2 37777.6 38011.2 2666.7 2733.1 2838.3 2979.7 3330.0 29491.9 29565.4 29889.3 29922.9 29965.4 2917.8 2961.4 2988.3 3016.5 3022.3 244445.0 244554.0 245140.0 247603.0 247760.0 31397.8 32433.7 50767.2 51098.5 51163.7 33723.7 33758.8 33846.5 33909.7 34012.8 13778.9 13886.0 13921.6 13970.6 13972.0 11521.5 11534.5 11556.8 11682.8 11774.1 7750.3 7774.0 7801.9 7849.2 7886.9 3093.7 3115.5 3133.5 3188.7 3190.7 898.2 923.3 943.8 962.5 982.6 27080.9 27816.0 28311.7 28421.3 28694.1 938.5 958.6 974.5 980.7 1076.4 13931.7 14324.9 14345.4 14614.7 14769.4 380682.0 383933.0 384911.0 387245.0 391781.0 48444.3 49708.5 49791.8 49796.8 50296.0 1170.8 1182.3 1204.0 1205.6 1206.2 25745.4 26596.6 27022.0 27171.0 27292.3 41268.4 41381.0 41477.6 41649.0 42107.1 318969.0 319890.0 320886.0 321511.0 323712.0 24867.8 24976.9 25357.0 25593.7 25646.6 40788.8 41817.6 41987.4 42348.2 42597.0 36004.8 36124.8 36349.0 36558.5 36594.5 35027.5 35059.0 35145.8 35334.1 35752.6 34695.5 34923.3 35375.5 35564.5 35735.5 31455.7 32339.4 32354.0 32497.0 32502.5 24581.1 24715.0 24743.2 25263.2 25319.4 17:03:53 INFO - PROCESS | 3476 | 17:03:53 INFO - PROCESS | 3476 | [#2] jquery.html Cycles:180 Average:23828.17 Median:4667.20 stddev:64802.19 (1388.5%) stddev-sans-first:64959.96 17:03:53 INFO - PROCESS | 3476 | Values: 335.1 348.1 350.8 354.9 366.1 15879.6 16066.4 16691.8 16706.1 16837.2 16137.6 16340.3 17031.1 17094.9 17161.4 4376.6 4665.8 4668.6 4728.3 4734.4 2902.8 4639.4 5202.9 5501.1 5508.8 5515.4 5547.4 5564.2 5580.1 5589.6 5396.0 5423.2 5527.6 5532.7 5533.6 5221.1 5351.6 5367.5 5381.8 5398.4 10816.5 10949.6 10980.1 11128.3 11132.3 1869.9 1893.4 1920.3 1949.6 1966.6 8535.6 8576.4 8936.2 9130.7 9215.0 1460.3 1462.0 1471.2 1484.1 1554.0 63680.0 65168.7 67419.7 68750.0 69710.7 9609.6 9801.4 9808.3 9902.3 10136.4 13214.1 13286.9 13377.3 13412.6 13526.6 7342.9 7360.6 7394.0 7451.7 7566.2 7130.9 7228.9 7234.7 7301.3 7361.9 4141.4 4144.3 4242.1 4279.6 4317.2 1586.0 1716.2 1731.6 1766.5 1779.1 825.3 828.9 899.4 912.4 915.1 15891.3 16070.6 16200.8 16507.0 16622.5 812.8 852.7 865.7 904.4 919.6 9140.6 9359.2 9402.2 9516.0 9579.1 384112.0 387427.0 396645.0 397551.0 399781.0 71476.6 71837.3 72888.6 72912.0 74449.3 891.4 896.3 899.2 926.9 927.1 14775.5 14873.0 14891.9 15174.6 15221.8 35268.5 35572.5 37619.6 37795.8 37986.0 49334.0 50069.0 50394.2 50407.2 50620.4 7307.1 7393.1 7573.9 7751.4 7842.5 11774.0 11782.1 11945.6 11957.3 12097.1 9346.3 10035.4 10133.3 10298.9 10449.7 9754.5 9838.6 10305.3 10370.0 10718.5 10179.5 10290.7 10519.6 10539.6 10681.0 7692.3 7705.8 7764.3 7933.3 7994.0 9835.5 10266.0 10346.3 10486.9 10636.8 17:03:53 INFO - PROCESS | 3476 | 17:03:53 INFO - PROCESS | 3476 | [#3] mootools.html Cycles:180 Average:4962.17 Median:5032.57 stddev:2832.30 (56.3%) stddev-sans-first:2827.50 17:03:53 INFO - PROCESS | 3476 | Values: 1385.7 1402.0 1468.4 1638.6 1639.5 6536.3 7365.1 7409.3 7867.5 7891.0 7560.7 7714.9 7727.7 7732.6 7780.1 2133.3 2168.2 2170.2 2171.9 2177.7 2123.8 2124.5 2152.7 2165.7 2170.4 2089.8 2099.8 2111.2 2111.7 2156.1 2053.1 2062.8 2064.4 2073.2 2081.5 2048.0 2091.8 2101.9 2102.1 2114.6 7782.8 7820.2 7848.7 7872.8 7876.7 4311.0 4410.4 4441.1 4448.8 4477.5 2642.0 2818.2 2829.9 2830.6 2842.1 913.5 917.6 918.8 937.7 1574.9 9968.5 10265.1 10291.5 10381.7 10498.5 3834.7 3923.8 3959.6 4060.5 4073.3 8212.1 8257.2 8299.7 8301.2 8326.8 4530.3 4561.0 4572.7 4590.7 4610.8 3492.9 4040.6 4091.0 4094.8 4167.3 3259.7 3289.3 3369.7 3388.4 3505.3 989.2 1004.5 1006.4 1007.0 1009.8 752.9 755.3 776.5 795.3 814.4 4928.7 4928.9 5136.3 5233.1 5321.7 373.0 375.7 382.6 384.2 388.5 3483.1 3494.4 3500.8 3518.5 3571.9 9317.3 9541.1 9660.5 9669.1 9703.3 9299.9 9471.6 9534.3 9547.3 9616.9 7241.9 7261.7 7286.0 7322.8 7409.8 5144.5 5148.0 5150.4 5178.5 5183.9 8644.8 8859.9 8864.8 8913.4 8991.2 8950.5 8967.7 9043.8 9045.5 9055.8 5531.6 6027.1 6063.3 6135.1 6154.6 6940.8 6998.3 7093.4 7115.5 7127.5 6411.5 6594.2 6640.2 6726.1 6750.9 6413.1 6532.9 6554.4 6582.0 6614.0 5988.6 6002.2 6008.0 6053.9 6065.9 4067.2 4097.4 4215.8 4233.6 4261.7 4100.4 4228.9 4312.5 4391.9 4424.6 17:03:53 INFO - PROCESS | 3476 | 17:03:53 INFO - PROCESS | 3476 | [#4] prototype.html Cycles:180 Average:4360.46 Median:5038.97 stddev:1279.77 (25.4%) stddev-sans-first:1246.20 17:03:53 INFO - PROCESS | 3476 | Values: 281.7 286.8 288.5 293.3 293.4 4959.5 5002.5 5062.9 5094.6 5094.7 4919.4 4941.6 5033.4 5044.5 5078.3 3631.2 3780.9 3846.6 3870.9 3900.7 3835.8 3857.7 3884.3 3890.7 3902.4 3851.6 3860.5 3880.3 3895.2 3904.3 3807.0 3859.7 3896.5 3909.7 3920.4 3375.6 3378.4 3382.3 3385.1 3411.2 4880.2 4906.8 4912.6 4918.9 4942.6 4425.3 4434.7 4449.7 4461.7 4464.3 5065.7 5192.7 5210.3 5233.6 5235.2 3683.2 3699.5 3729.6 3733.9 3738.5 5470.3 5488.2 5503.3 5514.9 5537.2 3639.3 3749.8 3754.3 3762.0 3774.8 3793.6 3798.1 3801.7 3807.2 3808.3 4384.2 4386.8 4387.5 4392.6 4403.9 5056.9 5190.8 5216.6 5218.0 5234.8 1326.2 1351.8 1352.1 1356.9 1357.9 829.2 845.7 858.9 860.7 869.5 4472.8 4505.6 4666.2 4712.6 4727.0 5395.3 5470.8 5488.2 5494.4 5520.6 4607.9 4750.0 4760.2 4790.3 4791.7 2883.6 2924.5 2944.1 2947.6 2962.2 5128.7 5159.9 5176.4 5213.6 5213.8 5370.0 5505.0 5509.7 5528.8 5569.6 5099.7 5106.6 5136.6 5138.9 5156.6 5372.6 5384.2 5448.9 5527.3 5527.7 5069.9 5235.9 5277.6 5287.8 5316.9 5114.2 5118.6 5169.2 5180.8 5191.6 3798.7 3841.5 3848.4 3854.7 3866.7 5183.4 5363.8 5392.9 5409.4 5414.2 5177.9 5211.6 5232.2 5243.1 5247.5 5125.8 5195.7 5200.2 5211.9 5227.9 4881.6 5222.4 5225.7 5243.0 5277.7 5155.7 5181.9 5341.2 5358.8 5379.4 5246.5 5250.2 5262.3 5272.6 5286.8 17:03:53 INFO - PROCESS | 3476 | 17:03:53 INFO - PROCESS | 3476 | [#5] yui.html Cycles:180 Average:15364.48 Median:29869.56 stddev:22136.85 (74.1%) stddev-sans-first:22170.82 17:03:53 INFO - PROCESS | 3476 | Values: 503.2 513.2 515.9 557.6 583.8 10914.6 11378.5 11422.4 11429.3 11497.7 11988.1 12232.6 12300.5 12361.1 12417.4 613.2 754.0 759.8 771.6 774.6 766.5 768.4 768.9 771.6 772.9 819.5 820.0 825.7 828.3 830.4 806.4 812.6 815.0 816.1 821.7 595.4 598.9 601.1 601.8 602.7 12034.5 12128.0 12143.8 12159.2 12163.3 12058.2 12501.0 12676.5 12759.5 12899.5 9591.4 9666.2 9810.1 9822.5 9912.8 3249.2 3315.2 3351.2 3366.4 3404.0 56835.7 58571.4 58752.0 58853.7 59143.7 9430.2 9473.3 9486.4 9551.5 9674.0 18473.4 18495.6 18591.8 18640.3 18697.5 5897.9 5900.6 6010.8 6027.0 6171.9 3333.2 3510.6 3547.9 3729.5 3776.7 2773.7 2827.3 2836.4 2842.3 2867.0 452.8 459.6 505.4 529.5 535.7 454.5 481.0 489.9 499.2 521.8 6926.9 7099.6 7131.8 7137.8 7299.2 493.3 521.3 524.8 530.6 535.8 3430.8 3511.7 3517.8 3530.4 3610.3 58353.7 94986.6 98103.0 100582.5 101237.5 51627.5 52188.5 52265.0 52392.7 52775.0 48238.8 48466.8 50347.2 72618.6 77691.6 6560.3 6575.6 6655.3 6683.5 6754.8 44142.6 44274.3 45608.5 46020.8 47046.0 56581.2 57114.4 62139.0 65901.3 66946.7 8874.2 8915.5 9012.2 9055.5 9070.8 9204.5 9256.9 9508.2 9544.5 10006.5 8407.7 8529.7 8567.0 8799.3 8946.6 8998.4 9172.5 9230.9 9349.7 9475.2 8223.6 8230.5 8278.5 8570.0 8649.0 7305.9 7381.2 7453.9 7534.8 7624.9 7763.8 7846.3 7882.8 8119.4 8137.5 17:03:53 INFO - PROCESS | 3476 | -------- Summary: end -------- 17:03:53 INFO - PROCESS | 3476 | 17:03:54 INFO - TEST-INFO | 3476: exit 0 17:03:54 INFO - TEST-OK | dromaeo_css | took 1118057ms 17:03:54 INFO - TEST-START | kraken 17:03:54 INFO - operating with platform_type : linux_ 17:03:54 INFO - Initialising browser for kraken test... 17:03:54 INFO - TEST-INFO | started process 3708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp46YSva/profile http://localhost:50124/getInfo.html) 17:04:00 INFO - PROCESS | 3708 | __metrics Screen width/height:1600/1200 17:04:00 INFO - PROCESS | 3708 | colorDepth:24 17:04:00 INFO - PROCESS | 3708 | Browser inner width/height: 1024/697 17:04:00 INFO - PROCESS | 3708 | __metrics 17:04:00 ERROR - PROCESS | 3708 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 17:04:01 INFO - TEST-INFO | 3708: exit 0 17:04:01 INFO - Browser initialized. 17:04:01 INFO - Running cycle 1/1 for kraken test... 17:04:01 INFO - TEST-INFO | started process 3825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp46YSva/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:13 INFO - PROCESS | 3825 | RSS: Main: 185380864 17:04:13 INFO - PROCESS | 3825 | 17:04:16 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50124/tests/kraken/driver.html?testName=audio-beat-detection) 17:04:17 INFO - PROCESS | 3825 | RSS: Main: 189558784 17:04:17 INFO - PROCESS | 3825 | 17:04:20 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50124/tests/kraken/driver.html?testName=audio-dft) 17:04:20 INFO - PROCESS | 3825 | RSS: Main: 189431808 17:04:20 INFO - PROCESS | 3825 | 17:04:23 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50124/tests/kraken/driver.html?testName=audio-fft) 17:04:24 INFO - PROCESS | 3825 | RSS: Main: 184934400 17:04:24 INFO - PROCESS | 3825 | 17:04:26 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50124/tests/kraken/driver.html?testName=audio-oscillator) 17:04:27 INFO - PROCESS | 3825 | RSS: Main: 185634816 17:04:27 INFO - PROCESS | 3825 | 17:04:29 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50124/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:04:30 INFO - PROCESS | 3825 | RSS: Main: 186138624 17:04:30 INFO - PROCESS | 3825 | 17:04:33 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50124/tests/kraken/driver.html?testName=imaging-darkroom) 17:04:34 INFO - PROCESS | 3825 | RSS: Main: 186306560 17:04:34 INFO - PROCESS | 3825 | 17:04:37 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50124/tests/kraken/driver.html?testName=imaging-desaturate) 17:04:38 INFO - PROCESS | 3825 | RSS: Main: 183496704 17:04:38 INFO - PROCESS | 3825 | 17:04:41 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50124/tests/kraken/driver.html?testName=json-parse-financial) 17:04:41 INFO - PROCESS | 3825 | RSS: Main: 184913920 17:04:41 INFO - PROCESS | 3825 | 17:04:44 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50124/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:04:44 INFO - PROCESS | 3825 | RSS: Main: 185323520 17:04:44 INFO - PROCESS | 3825 | 17:04:46 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50124/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:04:46 INFO - PROCESS | 3825 | RSS: Main: 185974784 17:04:46 INFO - PROCESS | 3825 | 17:04:48 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50124/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:04:49 INFO - PROCESS | 3825 | RSS: Main: 186470400 17:04:49 INFO - PROCESS | 3825 | 17:04:52 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:04:53 INFO - PROCESS | 3825 | RSS: Main: 186597376 17:04:53 INFO - PROCESS | 3825 | 17:04:55 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:04:56 INFO - PROCESS | 3825 | RSS: Main: 186073088 17:04:56 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:50124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50124/tests/kraken/driver.html?testName=ai-astar) 17:04:58 INFO - PROCESS | 3825 | RSS: Main: 186896384 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | __start_tp_report 17:04:58 INFO - PROCESS | 3825 | _x_x_mozilla_page_load 17:04:58 INFO - PROCESS | 3825 | _x_x_mozilla_page_load_details 17:04:58 INFO - PROCESS | 3825 | |i|pagename|runs| 17:04:58 INFO - PROCESS | 3825 | |0;ai-astar;115;112;118;115;117;117;119;116;115;115 17:04:58 INFO - PROCESS | 3825 | |1;audio-beat-detection;155;140;158;185;136;167;158;139;197;134 17:04:58 INFO - PROCESS | 3825 | |2;audio-dft;164;168;173;165;167;164;165;163;162;160 17:04:58 INFO - PROCESS | 3825 | |3;audio-fft;76;77;76;171;77;78;78;77;163;75 17:04:58 INFO - PROCESS | 3825 | |4;audio-oscillator;88;87;139;89;89;88;131;86;86;141 17:04:58 INFO - PROCESS | 3825 | |5;imaging-gaussian-blur;119;118;119;119;118;118;118;119;119;119 17:04:58 INFO - PROCESS | 3825 | |6;imaging-darkroom;149;148;148;149;149;148;148;148;149;151 17:04:58 INFO - PROCESS | 3825 | |7;imaging-desaturate;96;97;97;96;95;97;96;96;96;95 17:04:58 INFO - PROCESS | 3825 | |8;json-parse-financial;65;65;67;65;65;66;65;65;65;65 17:04:58 INFO - PROCESS | 3825 | |9;json-stringify-tinderbox;66;64;65;66;67;65;65;65;66;66 17:04:58 INFO - PROCESS | 3825 | |10;stanford-crypto-aes;85;84;84;86;86;83;86;86;117;89 17:04:58 INFO - PROCESS | 3825 | |11;stanford-crypto-ccm;134;136;136;137;144;140;139;134;136;136 17:04:58 INFO - PROCESS | 3825 | |12;stanford-crypto-pbkdf2;173;171;174;169;169;172;167;167;167;168 17:04:58 INFO - PROCESS | 3825 | |13;stanford-crypto-sha256-iterative;68;70;70;67;72;68;68;67;68;67 17:04:58 INFO - PROCESS | 3825 | __end_tp_report 17:04:58 INFO - PROCESS | 3825 | __start_cc_report 17:04:58 INFO - PROCESS | 3825 | _x_x_mozilla_cycle_collect,963 17:04:58 INFO - PROCESS | 3825 | __end_cc_report 17:04:58 INFO - PROCESS | 3825 | __startTimestamp1465517098648__endTimestamp 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | ------- Summary: start ------- 17:04:58 INFO - PROCESS | 3825 | Number of tests: 14 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.50 stddev:1.97 (1.7%) stddev-sans-first:2.06 17:04:58 INFO - PROCESS | 3825 | Values: 115.0 112.0 118.0 115.0 117.0 117.0 119.0 116.0 115.0 115.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#1] audio-beat-detection Cycles:10 Average:156.90 Median:158.00 stddev:21.27 (13.5%) stddev-sans-first:22.55 17:04:58 INFO - PROCESS | 3825 | Values: 155.0 140.0 158.0 185.0 136.0 167.0 158.0 139.0 197.0 134.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.60 (2.2%) stddev-sans-first:3.80 17:04:58 INFO - PROCESS | 3825 | Values: 164.0 168.0 173.0 165.0 167.0 164.0 165.0 163.0 162.0 160.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:38.11 (49.5%) stddev-sans-first:39.81 17:04:58 INFO - PROCESS | 3825 | Values: 76.0 77.0 76.0 171.0 77.0 78.0 78.0 77.0 163.0 75.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:87.50 stddev:24.03 (27.5%) stddev-sans-first:24.91 17:04:58 INFO - PROCESS | 3825 | Values: 88.0 87.0 139.0 89.0 89.0 88.0 131.0 86.0 86.0 141.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:04:58 INFO - PROCESS | 3825 | Values: 119.0 118.0 119.0 119.0 118.0 118.0 118.0 119.0 119.0 119.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 17:04:58 INFO - PROCESS | 3825 | Values: 149.0 148.0 148.0 149.0 149.0 148.0 148.0 148.0 149.0 151.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 17:04:58 INFO - PROCESS | 3825 | Values: 96.0 97.0 97.0 96.0 95.0 97.0 96.0 96.0 96.0 95.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 17:04:58 INFO - PROCESS | 3825 | Values: 65.0 65.0 67.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 17:04:58 INFO - PROCESS | 3825 | Values: 66.0 64.0 65.0 66.0 67.0 65.0 65.0 65.0 66.0 66.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:86.00 stddev:10.11 (11.8%) stddev-sans-first:10.64 17:04:58 INFO - PROCESS | 3825 | Values: 85.0 84.0 84.0 86.0 86.0 83.0 86.0 86.0 117.0 89.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:136.50 stddev:3.05 (2.2%) stddev-sans-first:3.00 17:04:58 INFO - PROCESS | 3825 | Values: 134.0 136.0 136.0 137.0 144.0 140.0 139.0 134.0 136.0 136.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:170.00 stddev:2.63 (1.5%) stddev-sans-first:2.50 17:04:58 INFO - PROCESS | 3825 | Values: 173.0 171.0 174.0 169.0 169.0 172.0 167.0 167.0 167.0 168.0 17:04:58 INFO - PROCESS | 3825 | 17:04:58 INFO - PROCESS | 3825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.74 17:04:58 INFO - PROCESS | 3825 | Values: 68.0 70.0 70.0 67.0 72.0 68.0 68.0 67.0 68.0 67.0 17:04:58 INFO - PROCESS | 3825 | -------- Summary: end -------- 17:04:58 INFO - PROCESS | 3825 | 17:04:59 INFO - TEST-INFO | 3825: exit 0 17:04:59 INFO - TEST-OK | kraken | took 65160ms 17:04:59 INFO - SUITE-END | took 1183s 17:04:59 INFO - Completed test suite (00:19:43) 17:04:59 INFO - javascript benchmark 17:04:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6140.514610219229, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2532.139072715277, 2615.992842755539, 2626.3959289363434, 2630.6448629435044, 2637.6307316975626, 4671.672982891195, 4710.434747830261, 4744.07490539345, 4747.477777444478, 4813.133635945528, 4602.746848923308, 4722.102800467908, 4757.215059515176, 4757.33397324374, 4764.618830493561, 4285.2929266671035, 4326.567343265664, 4396.494403143647, 4419.558044195571, 4445.1331990261915, 4072.4139474954095, 4408.3167109097985, 4441.888952776174, 4443.200223959686, 4448.844290449835, 4130.318497447917, 4231.090315582134, 4278.101598664253, 4383.0, 4451.465824101128, 4312.805923733408, 4317.244482215599, 4327.221100201962, 4329.19909816685, 4366.08312254427, 4304.913901721948, 4357.433533640607, 4362.629176519999, 4365.0, 4388.846390376321, 4677.74272415017, 4703.459102203256, 4718.598919091882, 4719.362886010379, 4755.453122890843, 5031.823886164003, 5044.672096313765, 5066.797328106872, 5067.898642027176, 5108.055009823194, 4922.1386257405165, 5067.341245638044, 5103.668261562986, 5107.974460127675, 5145.228215767627, 4717.9292310615365, 4726.976365118152, 4757.8096876125255, 4763.785629646674, 4764.380630518011, 5219.556337711337, 5234.0, 5248.055350036953, 5255.395629502656, 5291.391489978625, 4979.502049795064, 4982.451930287665, 5018.397792264952, 5028.0, 5031.421386540522, 5040.2691609716385, 5125.461826508163, 5143.305653736773, 5154.149565321755, 5193.37679478465, 4779.139754844092, 4952.281919121707, 4967.850964471072, 5004.899902001939, 5032.396112466454, 4862.270659401118, 4931.334269873593, 4941.085899108676, 4955.4548999610015, 4999.325091112653, 4216.367544868233, 4218.535961044283, 4224.5353011168745, 4272.700910936204, 4273.658107351466, 3683.723720720957, 3719.683826874692, 3760.398336266239, 3777.8299976500575, 3792.981035094807, 4277.850275240352, 4452.844150454784, 4474.798634061475, 4492.483364413069, 4498.145352383102, 5138.614603904647, 5150.793968241303, 5156.226566015052, 5170.638055336166, 5185.533302002837, 4484.148011877798, 4497.145542346943, 4502.212112880233, 4506.481754598198, 4584.862454126382, 4332.653387728974, 4521.909561808746, 4530.977345113253, 4542.091581683677, 4584.426946631671, 4836.347093142381, 4878.390201224847, 4879.73161476108, 4881.51184881509, 4940.1601727706375, 4980.626453016111, 5168.224766285088, 5175.948240517697, 5177.948220517897, 5221.034108689904, 4790.281457781361, 4811.037792441596, 4837.056773929191, 4839.612830973584, 4847.3698419205275, 5003.249512572997, 5035.974820125876, 5037.5214354636255, 5042.8814753026445, 5110.284560161655, 4786.827227329327, 5081.618878584047, 5105.387353517602, 5109.514596113363, 5116.897662046813, 4705.623550115914, 4792.856214313576, 4906.607471402351, 4971.328870602422, 5053.84838454847, 4967.776450059684, 4967.850964471072, 4984.152694041949, 5006.949930500648, 5031.84904452867, 4845.0, 4859.562639362474, 4879.0, 4906.313116163668, 4947.381577302837, 4768.618510519081, 4928.162212423825, 4984.077945580079, 4984.878402359585, 4984.928240428325, 4895.04546613407, 4909.4354149273295, 4915.950840491692, 4920.434150072788, 4961.7271050092595], "value": 4658.390817336297, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.4772257245904, 574.967932561053, 576.167438052015, 585.6251998720819, 597.4801922327575, 34882.47676284854, 38212.42681359782, 38301.23397532048, 38337.233255334875, 38350.616493835056, 38460.0, 38466.8076659617, 38554.22891542168, 38983.80508097463, 39002.41496377557, 7527.096748390187, 7635.923640763604, 7662.578558179298, 7691.461597688164, 7745.419093567977, 7523.6614352354, 7632.6183690815515, 7652.57910814905, 7711.074671039483, 7729.381649468029, 7675.462717609769, 7683.692652293929, 7709.344705700022, 7728.6522106505345, 7754.3796496280165, 7614.695412183533, 7656.464047516676, 7700.268474494942, 7727.227277272228, 7743.535387876689, 7583.544987300779, 7657.387409007266, 7666.425018123663, 7687.192844751333, 7689.231076892322, 37237.25525489475, 37549.62450375489, 37621.24757504834, 37777.62222377796, 38011.239775204616, 2666.6933302670245, 2733.098077634376, 2838.3471801485566, 2979.687132851041, 3330.0, 29491.85254073716, 29565.40869182626, 29889.25276868074, 29922.850385747934, 29965.400691986255, 2917.7519910807396, 2961.3633068890076, 2988.3276262840905, 3016.5173572228337, 3022.319978004953, 244445.0, 244554.0, 245140.0, 247603.0, 247760.0, 31397.8430107848, 32433.67566324354, 50767.23849142266, 51098.48901511011, 51163.74418127885, 33723.662763372544, 33758.831205844304, 33846.49230261548, 33909.66090339065, 34012.82993585016, 13778.931105344409, 13886.0, 13921.58235252944, 13970.580882573538, 13972.0, 11521.53913843437, 11534.480948357344, 11556.76886462266, 11682.766344673058, 11774.05807535395, 7750.263724946121, 7773.961130194426, 7801.882971755428, 7849.21507849222, 7886.921130788619, 3093.6751641077813, 3115.454795410794, 3133.4829753090485, 3188.681131886839, 3190.7128358447853, 898.2320116300469, 923.3213588012806, 943.8112377524523, 962.5091203486272, 982.577491678585, 27080.864595676896, 27816.0, 28311.71688283132, 28421.289467763472, 28694.13917582476, 938.4556956964944, 958.6405098088217, 974.5322245322285, 980.7401038724744, 1076.4079756134095, 13931.651708707363, 14324.928375358266, 14345.426182952773, 14614.707705846036, 14769.409223630935, 380682.0, 383933.0, 384911.0, 387245.0, 391781.0, 48444.27333589999, 49708.502914970384, 49791.75104124456, 49796.751016244685, 50296.0, 1170.7658468306372, 1182.266994463438, 1203.9819402708965, 1205.5659962413524, 1206.2460961898637, 25745.356366090247, 26596.601050983863, 27022.0, 27171.0, 27292.31769205786, 41268.38097428601, 41381.0, 41477.58522414737, 41649.0, 42107.10518026635, 318969.0, 319890.0, 320886.0, 321511.0, 323712.0, 24867.751322486543, 24976.875115625033, 25357.0, 25593.744062559137, 25646.615300770878, 40788.77633670995, 41817.58182418137, 41987.37018944657, 42348.15303693847, 42597.0, 36004.819975899954, 36124.81937590295, 36349.0, 36558.4516232262, 36594.45108323324, 35027.47458788171, 35059.0, 35145.82427087951, 35334.116647084025, 35752.64247357597, 34695.47956780701, 34923.30153396969, 35375.46936796002, 35564.466533001505, 35735.46396804102, 31455.685443145274, 32339.35321293514, 32354.0, 32497.0, 32502.51246231261, 24581.13966011181, 24715.0, 24743.204074811187, 25263.242102736946, 25319.367015824017], "value": 16227.237269048876, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.10025581314164, 348.0845376659386, 350.8333541567754, 354.92723991581727, 366.12130885873916, 15879.603009924758, 16066.357345706172, 16691.83308166918, 16706.081165535892, 16837.242324095416, 16137.575338994422, 16340.34638614454, 17031.148442577884, 17094.914525427386, 17161.399351022716, 4376.606105450509, 4665.790039448233, 4668.603168730645, 4728.314394412825, 4734.431868175824, 2902.767778577719, 4639.396878405802, 5202.8699282518055, 5501.119820828668, 5508.834734957938, 5515.420880807517, 5547.362053363874, 5564.221009058735, 5580.051391263474, 5589.636673616202, 5395.973020134894, 5423.2136340230645, 5527.55779537636, 5532.723363831833, 5533.612647114704, 5221.086309895753, 5351.625386222966, 5367.543758780508, 5381.838544843661, 5398.433164517708, 10816.459177041117, 10949.616763413242, 10980.066694330992, 11128.332300061942, 11132.33206007634, 1869.9252029918787, 1893.422506135628, 1920.3278852401688, 1949.629570381623, 1966.587016726489, 8535.573221338971, 8576.356773242032, 8936.240419564345, 9130.680426185118, 9215.0, 1460.2552698124034, 1461.9561413157621, 1471.1761413608306, 1484.1466156959684, 1553.992230038854, 63680.0, 65168.674156629386, 67419.66290168568, 68749.9999999995, 69710.65144674295, 9609.558566214984, 9801.362911410735, 9808.264380171515, 9902.257330700226, 10136.442495662663, 13214.141080829715, 13286.933565332112, 13377.264250466123, 13412.597622071353, 13526.59420217395, 7342.889856652155, 7360.595167265745, 7394.001809755721, 7451.739189128354, 7566.2433756625, 7130.893036604455, 7228.855422891513, 7234.674439650228, 7301.269873012762, 7361.852762944711, 4141.4409054777825, 4144.274751918462, 4242.066745316026, 4279.593438623326, 4317.222899878052, 1585.9603509912113, 1716.1933891071176, 1731.619043810385, 1766.496548483676, 1779.117829116839, 825.3191117328229, 828.8632375657949, 899.3794281945437, 912.4023764434306, 915.0849150849151, 15891.28489217988, 16070.598235044217, 16200.75698864518, 16507.0, 16622.50132496027, 812.7886749445187, 852.7058164933088, 865.6537385045906, 904.4256896870403, 919.5678031325266, 9140.634374625073, 9359.204467620328, 9402.247820174369, 9515.952420237993, 9579.13787759105, 384112.0, 387427.0, 396645.0, 397551.0, 399781.0, 71476.64261678659, 71837.28162718305, 72888.63555682187, 72912.0, 74449.25550744424, 891.362675686887, 896.2695403246333, 899.2401420799414, 926.9073092690677, 927.1146055516965, 14775.482858099915, 14873.0, 14891.851081489047, 15174.577875180466, 15221.847781522487, 35268.47097293491, 35572.466413003305, 37619.62380376161, 37795.81102094472, 37986.0, 49334.0, 50069.0, 50394.244086338, 50407.24389134093, 50620.44416002578, 7307.086614173229, 7393.112826460859, 7573.886391704239, 7751.418643601865, 7842.451028427955, 11774.0, 11782.116341274268, 11945.581904633296, 11957.282563046245, 12097.092718046359, 9346.299027573095, 10035.448050357301, 10133.341332813343, 10298.897011029794, 10449.738756531147, 9754.512274386394, 9838.60645574169, 10305.330153539995, 10370.0, 10718.464076796285, 10179.541920613738, 10290.742731431774, 10519.579216831242, 10539.57841686324, 10681.0, 7692.307692307719, 7705.7688269349765, 7764.262395072459, 7933.325667318342, 7994.0, 9835.459049752333, 10266.0, 10346.275760696679, 10486.895131048897, 10636.787264254826], "value": 7912.559719531189, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.7159282347122, 1401.9649508762284, 1468.4052958551783, 1638.5657800682814, 1639.4999525144826, 6536.346365363462, 7365.116186057674, 7409.296116868903, 7867.527948323104, 7890.960545197273, 7560.659770310335, 7714.922850771491, 7727.72952946647, 7732.613369331525, 7780.06639203295, 2133.25336132354, 2168.1544197762887, 2170.218721260345, 2171.934841954736, 2177.662462318335, 2123.766385697572, 2124.4582631428966, 2152.7309086364203, 2165.66432203008, 2170.4031391367344, 2089.7910208979133, 2099.8215151712047, 2111.187192930725, 2111.6515774897125, 2156.148321413041, 2053.1376821734907, 2062.7937206279325, 2064.3703670380605, 2073.2225415469197, 2081.5004398944297, 2048.0, 2091.7908209179113, 2101.88600041978, 2102.0645812613393, 2114.6405111131144, 7782.805429864242, 7820.178881217504, 7848.686052557948, 7872.803179920491, 7876.684932602689, 4311.0, 4410.448693913261, 4441.067375851075, 4448.777561121963, 4477.529859364785, 2641.9603705944232, 2818.168640251131, 2829.858507074638, 2830.575413687963, 2842.07632519432, 913.5204017890594, 917.6008436330218, 918.8346097702411, 937.6811883959418, 1574.9291281892342, 9968.501574921298, 10265.076143147078, 10291.53688084038, 10381.740456488573, 10498.530205771274, 3834.6740527054953, 3923.803809809498, 3959.6238357356006, 4060.451839001697, 4073.327900896378, 8212.137725538852, 8257.21556452136, 8299.6680132794, 8301.169883011771, 8326.750987351945, 4530.275155975029, 4560.996580752229, 4572.725636461823, 4590.655700822452, 4610.7694615269775, 3492.895213143559, 4040.5555388907196, 4090.9590904091174, 4094.774787386663, 4167.312393455107, 3259.6577359377397, 3289.309245058517, 3369.679880411357, 3388.373150967079, 3505.2814173094453, 989.1641562879355, 1004.4927311707687, 1006.4263369879098, 1007.0332480818496, 1009.7980403919246, 752.8644843928146, 755.2598453515585, 776.4836383804819, 795.3358945280639, 814.3851392198852, 4928.67963582366, 4928.8767780805765, 5136.255242989746, 5233.058049551118, 5321.6540924839765, 372.9813509324523, 375.6938095452198, 382.5791629207849, 384.1855266834329, 388.50853670107335, 3483.111806489329, 3494.3884820156372, 3500.807455589916, 3518.472229165646, 3571.8749843755863, 9317.301202409846, 9541.093596108358, 9660.516974151406, 9669.081437263449, 9703.272254580794, 9299.860502092473, 9471.621135154655, 9534.332596718303, 9547.331686781998, 9616.90383096174, 7241.89137162943, 7261.709531618676, 7286.0, 7322.780316590511, 7409.814754631069, 5144.536991670768, 5147.974260128675, 5150.433452320167, 5178.508041736029, 5183.948160518346, 8644.789729438009, 8859.867101993605, 8864.778380540538, 8913.37606367574, 8991.23574496149, 8950.507722075088, 8967.69968354598, 9043.773905652411, 9045.547722613974, 9055.81888362216, 5531.640443371168, 6027.126066720389, 6063.272407310975, 6135.14108024868, 6154.569180157525, 6940.826479338057, 6998.300169982961, 7093.432525398059, 7115.501914866117, 7127.46544009191, 6411.51913606472, 6594.241662208908, 6640.203175618956, 6726.091977582963, 6750.932490675031, 6413.134226879311, 6532.902006470002, 6554.377334153248, 6581.967090164519, 6614.04096406028, 5988.550858685703, 6002.249718785152, 6007.969960150346, 6053.880032194058, 6065.939340606537, 4067.2272268268935, 4097.44684467593, 4215.831366745296, 4233.576642335742, 4261.659067274672, 4100.425940368291, 4228.894277643083, 4312.504062032781, 4391.912161756683, 4424.60178583929], "value": 3917.4125980109975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.6591923772235, 286.7533920828089, 288.5095337925527, 293.31949876287007, 293.44978165938863, 4959.528844759751, 5002.549770520653, 5062.898742025157, 5094.566961808247, 5094.694318340898, 4919.409670839495, 4941.629377796662, 5033.389315419058, 5044.545990860822, 5078.289039534468, 3631.164832088608, 3780.924381512368, 3846.6345697158795, 3870.9225815483674, 3900.7074469414765, 3835.846566137351, 3857.6528112469873, 3884.2814079395403, 3890.708196885231, 3902.434147048676, 3851.595582463829, 3860.517435320585, 3880.3209438348176, 3895.2014836958356, 3904.258190943726, 3806.9619303806885, 3859.6526312632, 3896.4544963705102, 3909.6707119579337, 3920.372740361557, 3375.6118046424485, 3378.4256676365076, 3382.3066271414546, 3385.1198688340965, 3411.1642647551507, 4880.219164933629, 4906.803727850882, 4912.5578697917, 4918.90162196754, 4942.555170034678, 4425.269830477967, 4434.733915965053, 4449.663926438613, 4461.687681862271, 4464.263396539567, 5065.745743144303, 5192.662476938987, 5210.322658054467, 5233.607479439057, 5235.214717792362, 3683.226522430293, 3699.5375578052744, 3729.6083911189207, 3733.8879833605033, 3738.532683414573, 5470.316210473691, 5488.231647569303, 5503.3395992481155, 5514.862128446781, 5537.224788529649, 3639.3267245559655, 3749.8438397921304, 3754.342989976743, 3761.981190094032, 3774.8490060397826, 3793.5827059023486, 3798.1074447504816, 3801.657850793442, 3807.162424266712, 3808.257389809016, 4384.210842048462, 4386.806596701649, 4387.473503179639, 4392.582704643054, 4403.889902752393, 5056.873578160576, 5190.844274671766, 5216.634835561475, 5218.0, 5234.764435600331, 1326.1512631915582, 1351.776642138866, 1352.1278775189946, 1356.911800732969, 1357.9001009182593, 829.1915382502133, 845.678642115992, 858.8539948208819, 860.7417774667574, 869.4565896314804, 4472.753998530112, 4505.617022553054, 4666.160091183551, 4712.64655150865, 4726.983698504838, 5395.298611180521, 5470.835874923759, 5488.17677348401, 5494.395616482184, 5520.613557051048, 4607.9078418431445, 4749.952500474951, 4760.214564596872, 4790.281457781361, 4791.6645834791925, 2883.596296518489, 2924.546695262238, 2944.146197602714, 2947.5873377726707, 2962.215013021551, 5128.692278463304, 5159.948400515947, 5176.378834539804, 5213.56626927598, 5213.817516386908, 5369.95285919242, 5504.972475137599, 5509.669419834822, 5528.834134975958, 5569.637973531708, 5099.745012749348, 5106.646738614196, 5136.589072874236, 5138.948610513847, 5156.561692256125, 5372.597055220952, 5384.150332512272, 5448.863778405572, 5527.3141691782785, 5527.723613819373, 5069.8732531687, 5235.921461178009, 5277.577793776411, 5287.841364759063, 5316.946830531645, 5114.207297868837, 5118.564921981673, 5169.198774190007, 5180.818671346485, 5191.61185854496, 3798.715096367728, 3841.500604921454, 3848.383678854944, 3854.7494412863075, 3866.69066474687, 5183.429822719422, 5363.785448582013, 5392.865178370572, 5409.350877894678, 5414.184623995579, 5177.922331165111, 5211.609129315392, 5232.215167724872, 5243.134882744304, 5247.501487358695, 5125.76981524424, 5195.740212989411, 5200.2199670049795, 5211.9478805212975, 5227.928274703752, 4881.633877459276, 5222.42553319127, 5225.660332078555, 5243.0, 5277.656952298242, 5155.742212889266, 5181.896362072813, 5341.172118321666, 5358.758855851574, 5379.4082650907585, 5246.501582349671, 5250.18622113573, 5262.289590905179, 5272.630915836008, 5286.7795525878455], "value": 3944.841854704949, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.16474652077557, 513.1609817947655, 515.8529819001584, 557.5845994733924, 583.7664934026391, 10914.563417463301, 11378.544858205683, 11422.371769552672, 11429.314241145537, 11497.712557186074, 11988.100892433058, 12232.633021009362, 12300.507979680802, 12361.072919531049, 12417.441215145318, 613.1752792494088, 753.9660715267826, 759.7682706774445, 771.6334740998037, 774.6088225446169, 766.5209244222361, 768.4352001279055, 768.9461737678365, 771.5756334016297, 772.8879312499685, 819.4878201124297, 819.9918000820005, 825.6821123867325, 828.2545708862042, 830.3689196210893, 806.3629732511338, 812.585581353508, 814.9755507334789, 816.1104396208102, 821.650798410673, 595.4254144750337, 598.892199404107, 601.0713447723234, 601.8134378342684, 602.6564858030924, 12034.51861925522, 12128.0, 12143.757124857453, 12159.209651372632, 12163.331016794073, 12058.216215946024, 12501.0, 12676.478822541354, 12759.489620415172, 12899.484020639164, 9591.42451452908, 9666.226701863834, 9810.112421004469, 9822.508874556244, 9912.801743965152, 3249.1877030742316, 3315.1712071982006, 3351.162209447638, 3366.394049071166, 3403.9659603404143, 56835.71582142104, 58571.41428585702, 58752.0, 58853.7057314715, 59143.70428147875, 9430.245580353556, 9473.28950328728, 9486.383385079947, 9551.522423878778, 9674.0, 18473.44579662612, 18495.630087398178, 18591.814081859007, 18640.254389824528, 18697.53256168607, 5897.852553686193, 5900.586958912835, 6010.759569617167, 6027.0, 6171.938280617136, 3333.2000319923045, 3510.613832478425, 3547.8580856765957, 3729.4965179700935, 3776.735628505978, 2773.653293338333, 2827.3355761396056, 2836.3901761121456, 2842.317843717493, 2866.956995645067, 452.81660927323827, 459.60244388603616, 505.3809083872227, 529.4863981937515, 535.7267793425303, 454.5182106966626, 480.96152307815294, 489.9093667671492, 499.188818170473, 521.7860677122362, 6926.896096558556, 7099.574025558483, 7131.832191015964, 7137.82155446118, 7299.160596531361, 493.30444073855693, 521.257208477925, 524.7638562646824, 530.5702381071344, 535.8312131678509, 3430.776999495025, 3511.701505372021, 3517.7889326640484, 3530.417481115587, 3610.2598967212184, 58353.70823145857, 94986.57520137203, 98103.0, 100582.4970875141, 101237.49381253195, 51627.48372516227, 52188.47811521912, 52265.0, 52392.73803630957, 52775.0, 48238.758806206446, 48466.75766621215, 50347.24479132743, 72618.63690681619, 77691.61154194192, 6560.27836937946, 6575.572587781779, 6655.301193374819, 6683.532152749261, 6754.831129221809, 44142.558574413844, 44274.3358849624, 45608.54391456043, 46020.76989615164, 47046.0, 56581.15128272997, 57114.42885571258, 62139.0, 65901.34098658952, 66946.66526667336, 8874.245689116497, 8915.509646969478, 9012.188902998761, 9055.501947392957, 9070.818583628423, 9204.493752843659, 9256.861147082664, 9508.239340852853, 9544.475053872104, 10006.499025146286, 8407.70573029941, 8529.658813647384, 8567.0, 8799.34004949644, 8946.552672366226, 8998.370114091951, 9172.541372931193, 9230.907690923004, 9349.672761453316, 9475.194608458083, 8223.588820558829, 8230.547319897463, 8278.503289802631, 8570.0, 8649.0, 7305.853882922418, 7381.1511676157925, 7453.9254607455405, 7534.849303014019, 7624.923750762421, 7763.844723105619, 7846.254605812439, 7882.763517094496, 8119.391045671717, 8137.471064380797], "value": 5799.036470971552, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 118.0, 115.0, 117.0, 117.0, 119.0, 116.0, 115.0, 115.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 140.0, 158.0, 185.0, 136.0, 167.0, 158.0, 139.0, 197.0, 134.0], "value": 156.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 173.0, 165.0, 167.0, 164.0, 165.0, 163.0, 162.0, 160.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 171.0, 77.0, 78.0, 78.0, 77.0, 163.0, 75.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 139.0, 89.0, 89.0, 88.0, 131.0, 86.0, 86.0, 141.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 119.0, 119.0, 118.0, 118.0, 118.0, 119.0, 119.0, 119.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0, 151.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 66.0, 67.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 86.0, 86.0, 83.0, 86.0, 86.0, 117.0, 89.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 136.0, 137.0, 144.0, 140.0, 139.0, 134.0, 136.0, 136.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 174.0, 169.0, 169.0, 172.0, 167.0, 167.0, 167.0, 168.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 70.0, 67.0, 72.0, 68.0, 68.0, 67.0, 68.0, 67.0], "value": 68.5, "unit": "score"}]}]} 17:04:59 INFO - Return code: 0 17:04:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:04:59 ERROR - # TBPL SUCCESS # 17:04:59 INFO - Running post-action listener: _resource_record_post_action 17:04:59 INFO - ##### 17:04:59 INFO - ##### Finished run-tests step (success) 17:04:59 INFO - ##### 17:04:59 INFO - Running post-run listener: _resource_record_post_run 17:05:00 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7917568; Write bytes: 408801280; Read time: 1740; Write time: 410428 17:05:00 INFO - TinderboxPrint: CPU usage
13.5% 17:05:00 INFO - TinderboxPrint: I/O read bytes / time
7,917,568 / 1,740 17:05:00 INFO - TinderboxPrint: I/O write bytes / time
408,801,280 / 410,428 17:05:00 INFO - TinderboxPrint: CPU idle
8,282.1 (86.5%) 17:05:00 INFO - TinderboxPrint: CPU user
1,230.0 (12.8%) 17:05:00 INFO - TinderboxPrint: Swap in / out
0 / 0 17:05:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 86843392; Read time: 0; Write time: 86732 17:05:00 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 6025216; Write bytes: 321732608; Read time: 1300; Write time: 323628 17:05:00 INFO - Running post-run listener: _upload_blobber_files 17:05:00 INFO - Blob upload gear active. 17:05:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:05:00 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 17:05:00 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:05:00 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:05:00 INFO - (blobuploader) - INFO - Open directory for files ... 17:05:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:05:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:05:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:01 INFO - (blobuploader) - INFO - Done attempting. 17:05:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:05:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:05:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:05 INFO - (blobuploader) - INFO - Done attempting. 17:05:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:05:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:05:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:06 INFO - (blobuploader) - INFO - Done attempting. 17:05:06 INFO - (blobuploader) - INFO - Iteration through files over. 17:05:06 INFO - Return code: 0 17:05:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:05:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:05:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73b3f189122ab1a81c8afa807eda1da7658787a3c0eadb4199828fb0ba25c5077f00372df72ab1d68b8de799411b9b95c8779c98f7d498588a6fd9fdf2084880", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/561f214dec6f99a7bb67c53c5fe0653b41f204f8bd4ef62993b4ec375738bb9a5144b4c5acce67ff6287cb858e8b815b1ff2016cb37b3aaa0f36c8e0bc0dd969", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3fdc3d1ec2b5c9b87ca3c55db0e3b2c4d60f0864621db2a81825fcd11063a3222199fbe0baaaf5671cce8e34be4e0fe095c7a12ede2a4804fe3336671607f53c"} 17:05:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:05:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:05:06 INFO - Contents: 17:05:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73b3f189122ab1a81c8afa807eda1da7658787a3c0eadb4199828fb0ba25c5077f00372df72ab1d68b8de799411b9b95c8779c98f7d498588a6fd9fdf2084880", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/561f214dec6f99a7bb67c53c5fe0653b41f204f8bd4ef62993b4ec375738bb9a5144b4c5acce67ff6287cb858e8b815b1ff2016cb37b3aaa0f36c8e0bc0dd969", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3fdc3d1ec2b5c9b87ca3c55db0e3b2c4d60f0864621db2a81825fcd11063a3222199fbe0baaaf5671cce8e34be4e0fe095c7a12ede2a4804fe3336671607f53c"} 17:05:06 INFO - Running post-run listener: copy_logs_to_upload_dir 17:05:06 INFO - Copying logs to upload dir... 17:05:06 INFO - mkdir: /builds/slave/test/build/upload/logs 17:05:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.180617 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-09 17:05:06.354059) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 17:05:06.357179) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991 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/Fx-Team-Non-PGO/sha512/73b3f189122ab1a81c8afa807eda1da7658787a3c0eadb4199828fb0ba25c5077f00372df72ab1d68b8de799411b9b95c8779c98f7d498588a6fd9fdf2084880", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/561f214dec6f99a7bb67c53c5fe0653b41f204f8bd4ef62993b4ec375738bb9a5144b4c5acce67ff6287cb858e8b815b1ff2016cb37b3aaa0f36c8e0bc0dd969", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3fdc3d1ec2b5c9b87ca3c55db0e3b2c4d60f0864621db2a81825fcd11063a3222199fbe0baaaf5671cce8e34be4e0fe095c7a12ede2a4804fe3336671607f53c"} build_url:https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011106 build_url: 'https://queue.taskcluster.net/v1/task/DJ9vfeIZTZissWPsBQgdxw/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/Fx-Team-Non-PGO/sha512/73b3f189122ab1a81c8afa807eda1da7658787a3c0eadb4199828fb0ba25c5077f00372df72ab1d68b8de799411b9b95c8779c98f7d498588a6fd9fdf2084880", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/561f214dec6f99a7bb67c53c5fe0653b41f204f8bd4ef62993b4ec375738bb9a5144b4c5acce67ff6287cb858e8b815b1ff2016cb37b3aaa0f36c8e0bc0dd969", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3fdc3d1ec2b5c9b87ca3c55db0e3b2c4d60f0864621db2a81825fcd11063a3222199fbe0baaaf5671cce8e34be4e0fe095c7a12ede2a4804fe3336671607f53c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 17:05:06.381788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:05:06.382114) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465515850.716698-859471991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:05:06.464193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 17:05:06.464514) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 17:05:06.464794) ========= ========= Total master_lag: 0.34 =========