builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1465903571.74 results: success (0) buildid: 20160614031626 builduid: a4077a0f8bca43aa86a06f3b4fdd315e revision: a00cf073f5c00380d4e42b13bc0cd3146b708845 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:11.738153) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:11.738653) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:11.738991) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:11.750890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:11.751185) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 04:26:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-06-14 04:26:12 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115695 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:11.878825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:11.879171) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014993 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:11.928327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 04:26:11.928734) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a00cf073f5c00380d4e42b13bc0cd3146b708845 --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 a00cf073f5c00380d4e42b13bc0cd3146b708845 --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=a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 04:26:13,048 truncating revision to first 12 chars 2016-06-14 04:26:13,048 Setting DEBUG logging. 2016-06-14 04:26:13,048 attempt 1/10 2016-06-14 04:26:13,048 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a00cf073f5c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 04:26:14,130 unpacking tar archive at: fx-team-a00cf073f5c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.424076 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 04:26:13.366178) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:13.366509) ========= script_repo_revision: a00cf073f5c00380d4e42b13bc0cd3146b708845 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:13.366906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:13.367195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 04:26:13.376703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-14 04:26:13.376969) ========= /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=a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:26:14 INFO - MultiFileLogger online at 20160614 04:26:14 in /builds/slave/test 04:26:14 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 04:26:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:14 INFO - {'append_to_log': False, 04:26:14 INFO - 'base_work_dir': '/builds/slave/test', 04:26:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:26:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:14 INFO - 'branch': 'Fx-Team-Non-PGO', 04:26:14 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:14 INFO - 'config_files': ('talos/linux_config.py',), 04:26:14 INFO - 'default_actions': ('clobber', 04:26:14 INFO - 'read-buildbot-config', 04:26:14 INFO - 'download-and-extract', 04:26:14 INFO - 'populate-webroot', 04:26:14 INFO - 'create-virtualenv', 04:26:14 INFO - 'install', 04:26:14 INFO - 'run-tests'), 04:26:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:14 INFO - 'download_minidump_stackwalk': True, 04:26:14 INFO - 'download_symbols': 'ondemand', 04:26:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:14 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:14 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:14 INFO - 'installer_path': 'installer.exe', 04:26:14 INFO - 'log_level': 'info', 04:26:14 INFO - 'log_name': 'talos', 04:26:14 INFO - 'log_to_console': True, 04:26:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:26:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:26:14 INFO - 'opt_config_files': (), 04:26:14 INFO - 'pip_index': False, 04:26:14 INFO - 'sps_profile': False, 04:26:14 INFO - 'sps_profile_interval': 0, 04:26:14 INFO - 'suite': 'dromaeojs-e10s', 04:26:14 INFO - 'system_bits': '32', 04:26:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:14 INFO - 'title': 'talos-linux64-ix-002', 04:26:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:14 INFO - 'use_talos_json': True, 04:26:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:14 INFO - 'work_dir': 'build'} 04:26:14 INFO - ##### 04:26:14 INFO - ##### Running clobber step. 04:26:14 INFO - ##### 04:26:14 INFO - Running pre-action listener: _resource_record_pre_action 04:26:14 INFO - Running main action method: clobber 04:26:14 INFO - rmtree: /builds/slave/test/build 04:26:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:15 INFO - Running post-action listener: _resource_record_post_action 04:26:15 INFO - ##### 04:26:15 INFO - ##### Finished clobber step (success) 04:26:15 INFO - ##### 04:26:15 INFO - ##### 04:26:15 INFO - ##### Running read-buildbot-config step. 04:26:15 INFO - ##### 04:26:15 INFO - Running pre-action listener: _resource_record_pre_action 04:26:15 INFO - Running main action method: read_buildbot_config 04:26:15 INFO - Using buildbot properties: 04:26:15 INFO - { 04:26:15 INFO - "project": "", 04:26:15 INFO - "product": "firefox", 04:26:15 INFO - "script_repo_revision": "production", 04:26:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:26:15 INFO - "repository": "", 04:26:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:26:15 INFO - "buildid": "20160614031626", 04:26:15 INFO - "pgo_build": "False", 04:26:15 INFO - "basedir": "/builds/slave/test", 04:26:15 INFO - "buildnumber": 1587, 04:26:15 INFO - "slavename": "talos-linux64-ix-002", 04:26:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:26:15 INFO - "platform": "ubuntu64_hw", 04:26:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:26:15 INFO - "branch": "fx-team", 04:26:15 INFO - "repo_path": "integration/fx-team", 04:26:15 INFO - "revision": "a00cf073f5c00380d4e42b13bc0cd3146b708845", 04:26:15 INFO - "stage_platform": "linux64", 04:26:15 INFO - "builduid": "a4077a0f8bca43aa86a06f3b4fdd315e", 04:26:15 INFO - "slavebuilddir": "test" 04:26:15 INFO - } 04:26:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:26:15 INFO - Running post-action listener: _resource_record_post_action 04:26:15 INFO - ##### 04:26:15 INFO - ##### Finished read-buildbot-config step (success) 04:26:15 INFO - ##### 04:26:15 INFO - ##### 04:26:15 INFO - ##### Running download-and-extract step. 04:26:15 INFO - ##### 04:26:15 INFO - Running pre-action listener: _resource_record_pre_action 04:26:15 INFO - Running main action method: download_and_extract 04:26:15 INFO - mkdir: /builds/slave/test/build/tests 04:26: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')]} 04:26:15 INFO - https://queue.taskcluster.net/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:26:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:26:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:26:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/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 04:26:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/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 04:26:15 INFO - Downloaded 1361 bytes. 04:26:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:26:15 INFO - Using the following test package requirements: 04:26:15 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:26:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:26:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:15 INFO - u'jsshell-linux-x86_64.zip'], 04:26:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:26:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:26:15 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:26:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:26:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:26:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:26: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')]} 04:26:15 INFO - https://queue.taskcluster.net/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:26:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:26:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/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 04:26:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/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 04:26:16 INFO - Downloaded 22653673 bytes. 04:26:16 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'] 04:26:16 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 04:26:17 INFO - Return code: 0 04:26:17 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 04:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:17 INFO - https://queue.taskcluster.net/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:26:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:26:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/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 04:26:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/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 04:26:19 INFO - Downloaded 22653673 bytes. 04:26:19 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'] 04:26:19 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 04:26:20 INFO - Return code: 0 04:26: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')]} 04:26:20 INFO - https://queue.taskcluster.net/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:26:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/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 04:26:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/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 04:26:21 INFO - Downloaded 14405384 bytes. 04:26:21 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'] 04:26:21 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 04:26:21 INFO - Return code: 0 04:26: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')]} 04:26:21 INFO - https://queue.taskcluster.net/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:26:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:26:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:26:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/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 04:26:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/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 04:26:23 INFO - Downloaded 55393814 bytes. 04:26:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:26:23 INFO - mkdir: /builds/slave/test/properties 04:26:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:26:23 INFO - Writing to file /builds/slave/test/properties/build_url 04:26:23 INFO - Contents: 04:26:23 INFO - build_url:https://queue.taskcluster.net/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:26:24 INFO - Running post-action listener: _resource_record_post_action 04:26:24 INFO - Running post-action listener: set_extra_try_arguments 04:26:24 INFO - ##### 04:26:24 INFO - ##### Finished download-and-extract step (success) 04:26:24 INFO - ##### 04:26:24 INFO - ##### 04:26:24 INFO - ##### Running populate-webroot step. 04:26:24 INFO - ##### 04:26:24 INFO - Running pre-action listener: _resource_record_pre_action 04:26:24 INFO - Running main action method: populate_webroot 04:26:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:26:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:26:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:26:24 INFO - '--tppagecycles', 04:26:24 INFO - '7'], 04:26:24 INFO - 'tests': ['tsvgm']}}, 04:26:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:26:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:26:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:26:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:26:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:26:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:26:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:24 INFO - 'talos_options': ['--disable-e10s'], 04:26:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:24 INFO - 'talos_options': ['--disable-e10s'], 04:26:24 INFO - 'tests': ['damp', 'tps']}, 04:26:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:24 INFO - 'tests': ['damp', 'tps']}, 04:26:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:26:24 INFO - 'tests': ['dromaeo_dom']}, 04:26:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:26:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:26:24 INFO - 'tests': ['basic_compositor_video']}, 04:26:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:26:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:26:24 INFO - 'tests': ['a11yr', 04:26:24 INFO - 'ts_paint', 04:26:24 INFO - 'tpaint', 04:26:24 INFO - 'sessionrestore', 04:26:24 INFO - 'sessionrestore_no_auto_restore', 04:26:24 INFO - 'tabpaint']}, 04:26:24 INFO - 'other-e10s': {'tests': ['a11yr', 04:26:24 INFO - 'ts_paint', 04:26:24 INFO - 'tpaint', 04:26:24 INFO - 'sessionrestore', 04:26:24 INFO - 'sessionrestore_no_auto_restore', 04:26:24 INFO - 'tabpaint']}, 04:26:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:26:24 INFO - 'ts_paint', 04:26:24 INFO - 'tpaint', 04:26:24 INFO - 'sessionrestore', 04:26:24 INFO - 'sessionrestore_no_auto_restore', 04:26:24 INFO - 'tabpaint']}, 04:26:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:26:24 INFO - 'ts_paint', 04:26:24 INFO - 'tpaint', 04:26:24 INFO - 'sessionrestore', 04:26:24 INFO - 'sessionrestore_no_auto_restore', 04:26:24 INFO - 'tabpaint']}, 04:26:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:26:24 INFO - 'tests': ['a11yr', 04:26:24 INFO - 'ts_paint', 04:26:24 INFO - 'tpaint', 04:26:24 INFO - 'sessionrestore', 04:26:24 INFO - 'sessionrestore_no_auto_restore', 04:26:24 INFO - 'tabpaint']}, 04:26:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:26:24 INFO - 'tests': ['a11yr', 04:26:24 INFO - 'ts_paint', 04:26:24 INFO - 'tpaint', 04:26:24 INFO - 'sessionrestore', 04:26:24 INFO - 'sessionrestore_no_auto_restore', 04:26:24 INFO - 'tabpaint']}, 04:26:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:26:24 INFO - 'tests': ['tsvgx', 04:26:24 INFO - 'tsvgr_opacity', 04:26:24 INFO - 'tart', 04:26:24 INFO - 'tscrollx', 04:26:24 INFO - 'cart']}, 04:26:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:26:24 INFO - 'tsvgr_opacity', 04:26:24 INFO - 'tart', 04:26:24 INFO - 'tscrollx', 04:26:24 INFO - 'cart']}, 04:26:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:24 INFO - 'talos_options': ['--disable-e10s'], 04:26:24 INFO - 'tests': ['tp5o']}, 04:26:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:24 INFO - 'tests': ['tp5o']}, 04:26:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:24 INFO - 'talos_options': ['--disable-e10s', 04:26:24 INFO - '--xperf_path', 04:26:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:24 INFO - 'tests': ['tp5n']}, 04:26:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:24 INFO - 'talos_options': ['--xperf_path', 04:26:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:24 INFO - 'tests': ['tp5n']}}, 04:26:24 INFO - 'talos.zip': {'path': '', 04:26:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:26:24 INFO - Running post-action listener: _resource_record_post_action 04:26:24 INFO - ##### 04:26:24 INFO - ##### Finished populate-webroot step (success) 04:26:24 INFO - ##### 04:26:24 INFO - ##### 04:26:24 INFO - ##### Running create-virtualenv step. 04:26:24 INFO - ##### 04:26:24 INFO - Running pre-action listener: _resource_record_pre_action 04:26:24 INFO - Running main action method: create_virtualenv 04:26:24 INFO - Creating virtualenv /builds/slave/test/build/venv 04:26:24 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 04:26:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:26:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:26:24 INFO - Using real prefix '/usr' 04:26:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:26:24 INFO - Installing distribute.............................................................................................................................................................................................done. 04:26:26 INFO - Installing pip.................done. 04:26:26 INFO - Return code: 0 04:26:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:26: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')]} 04:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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')]} 04:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f224c188f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f47020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd92e0>, '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 0x1f45140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f455d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', '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 04:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:26:26 INFO - Using env: {'DISPLAY': ':0', 04:26:26 INFO - 'HOME': '/home/cltbld', 04:26:26 INFO - 'LANG': 'en_US.UTF-8', 04:26:26 INFO - 'LANGUAGE': 'en_US:en', 04:26:26 INFO - 'LOGNAME': 'cltbld', 04:26:26 INFO - 'MAIL': '/var/mail/cltbld', 04:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:26 INFO - 'MOZ_NO_REMOTE': '1', 04:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:26 INFO - 'NO_EM_RESTART': '1', 04:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:26 INFO - 'PWD': '/builds/slave/test', 04:26:26 INFO - 'SHELL': '/bin/bash', 04:26:26 INFO - 'SHLVL': '1', 04:26:26 INFO - 'TERM': 'linux', 04:26:26 INFO - 'TMOUT': '86400', 04:26:26 INFO - 'USER': 'cltbld', 04:26:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', 04:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:26 INFO - '_': '/tools/buildbot/bin/python'} 04:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:26 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 04:26:26 INFO - Cleaning up... 04:26:26 INFO - Return code: 0 04:26:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:26: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')]} 04:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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')]} 04:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f224c188f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f47020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd92e0>, '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 0x1f45140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f455d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', '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 04:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:26:26 INFO - Using env: {'DISPLAY': ':0', 04:26:26 INFO - 'HOME': '/home/cltbld', 04:26:26 INFO - 'LANG': 'en_US.UTF-8', 04:26:26 INFO - 'LANGUAGE': 'en_US:en', 04:26:26 INFO - 'LOGNAME': 'cltbld', 04:26:26 INFO - 'MAIL': '/var/mail/cltbld', 04:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:26 INFO - 'MOZ_NO_REMOTE': '1', 04:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:26 INFO - 'NO_EM_RESTART': '1', 04:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:26 INFO - 'PWD': '/builds/slave/test', 04:26:26 INFO - 'SHELL': '/bin/bash', 04:26:26 INFO - 'SHLVL': '1', 04:26:26 INFO - 'TERM': 'linux', 04:26:26 INFO - 'TMOUT': '86400', 04:26:26 INFO - 'USER': 'cltbld', 04:26:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', 04:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:26 INFO - '_': '/tools/buildbot/bin/python'} 04:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:27 INFO - Downloading/unpacking psutil>=3.1.1 04:26:27 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 04:26:27 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 04:26:27 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 04:26:27 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 04:26:27 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 04:26:27 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 04:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:26:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:29 INFO - Installing collected packages: psutil 04:26:29 INFO - Running setup.py install for psutil 04:26:29 INFO - building 'psutil._psutil_linux' extension 04:26:29 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 04:26:29 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 04:26:29 INFO - building 'psutil._psutil_posix' extension 04:26:29 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 04:26:29 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 04:26:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:29 INFO - Successfully installed psutil 04:26:29 INFO - Cleaning up... 04:26:29 INFO - Return code: 0 04:26:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:26: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')]} 04:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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')]} 04:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:29 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 0x7f224c188f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f47020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd92e0>, '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 0x1f45140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f455d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', '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 04:26:29 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 04:26:29 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 04:26:29 INFO - Using env: {'DISPLAY': ':0', 04:26:29 INFO - 'HOME': '/home/cltbld', 04:26:29 INFO - 'LANG': 'en_US.UTF-8', 04:26:29 INFO - 'LANGUAGE': 'en_US:en', 04:26:29 INFO - 'LOGNAME': 'cltbld', 04:26:29 INFO - 'MAIL': '/var/mail/cltbld', 04:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:29 INFO - 'MOZ_NO_REMOTE': '1', 04:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:29 INFO - 'NO_EM_RESTART': '1', 04:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:29 INFO - 'PWD': '/builds/slave/test', 04:26:29 INFO - 'SHELL': '/bin/bash', 04:26:29 INFO - 'SHLVL': '1', 04:26:29 INFO - 'TERM': 'linux', 04:26:29 INFO - 'TMOUT': '86400', 04:26:29 INFO - 'USER': 'cltbld', 04:26:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', 04:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:29 INFO - '_': '/tools/buildbot/bin/python'} 04:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:26:31 INFO - Installing collected packages: mozsystemmonitor 04:26:31 INFO - Running setup.py install for mozsystemmonitor 04:26:31 INFO - Successfully installed mozsystemmonitor 04:26:31 INFO - Cleaning up... 04:26:31 INFO - Return code: 0 04:26:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:32 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 0x7f224c188f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f47020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd92e0>, '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 0x1f45140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f455d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', '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 04:26:32 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 04:26:32 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 04:26:32 INFO - Using env: {'DISPLAY': ':0', 04:26:32 INFO - 'HOME': '/home/cltbld', 04:26:32 INFO - 'LANG': 'en_US.UTF-8', 04:26:32 INFO - 'LANGUAGE': 'en_US:en', 04:26:32 INFO - 'LOGNAME': 'cltbld', 04:26:32 INFO - 'MAIL': '/var/mail/cltbld', 04:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:32 INFO - 'MOZ_NO_REMOTE': '1', 04:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:32 INFO - 'NO_EM_RESTART': '1', 04:26:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:32 INFO - 'PWD': '/builds/slave/test', 04:26:32 INFO - 'SHELL': '/bin/bash', 04:26:32 INFO - 'SHLVL': '1', 04:26:32 INFO - 'TERM': 'linux', 04:26:32 INFO - 'TMOUT': '86400', 04:26:32 INFO - 'USER': 'cltbld', 04:26:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', 04:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:32 INFO - '_': '/tools/buildbot/bin/python'} 04:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:32 INFO - Downloading/unpacking jsonschema==2.5.1 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:32 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 04:26:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:26:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:34 INFO - Downloading functools32-3.2.3-2.tar.gz 04:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:26:34 INFO - warning: no files found matching '*.txt' 04:26:34 INFO - no previously-included directories found matching 'build' 04:26:34 INFO - no previously-included directories found matching 'dist' 04:26:34 INFO - no previously-included directories found matching '.git*' 04:26:34 INFO - Installing collected packages: jsonschema, functools32 04:26:34 INFO - Running setup.py install for functools32 04:26:34 INFO - warning: no files found matching '*.txt' 04:26:34 INFO - no previously-included directories found matching 'build' 04:26:34 INFO - no previously-included directories found matching 'dist' 04:26:34 INFO - no previously-included directories found matching '.git*' 04:26:34 INFO - Successfully installed jsonschema functools32 04:26:34 INFO - Cleaning up... 04:26:34 INFO - Return code: 0 04:26:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:26:34 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')]} 04:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:34 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')]} 04:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:34 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 0x7f224c188f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f47020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd92e0>, '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 0x1f45140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f455d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', '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 04:26:34 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 04:26:34 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 04:26:34 INFO - Using env: {'DISPLAY': ':0', 04:26:34 INFO - 'HOME': '/home/cltbld', 04:26:34 INFO - 'LANG': 'en_US.UTF-8', 04:26:34 INFO - 'LANGUAGE': 'en_US:en', 04:26:34 INFO - 'LOGNAME': 'cltbld', 04:26:34 INFO - 'MAIL': '/var/mail/cltbld', 04:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:34 INFO - 'MOZ_NO_REMOTE': '1', 04:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:34 INFO - 'NO_EM_RESTART': '1', 04:26:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:34 INFO - 'PWD': '/builds/slave/test', 04:26:34 INFO - 'SHELL': '/bin/bash', 04:26:34 INFO - 'SHLVL': '1', 04:26:34 INFO - 'TERM': 'linux', 04:26:34 INFO - 'TMOUT': '86400', 04:26:34 INFO - 'USER': 'cltbld', 04:26:34 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', 04:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:34 INFO - '_': '/tools/buildbot/bin/python'} 04:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:34 INFO - Downloading/unpacking blobuploader==1.2.4 04:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:36 INFO - Downloading blobuploader-1.2.4.tar.gz 04:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:26:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:26:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:26:37 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 04:26:37 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 04:26:37 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 04:26:37 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 04:26:37 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 04:26:37 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 04:26:37 INFO - Downloading docopt-0.6.1.tar.gz 04:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:26:37 INFO - Installing collected packages: blobuploader, requests, docopt 04:26:37 INFO - Running setup.py install for blobuploader 04:26:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:26:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:26:37 INFO - Running setup.py install for requests 04:26:37 INFO - Running setup.py install for docopt 04:26:37 INFO - Successfully installed blobuploader requests docopt 04:26:37 INFO - Cleaning up... 04:26:38 INFO - Return code: 0 04:26:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:38 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 0x7f224c188f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f47020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd92e0>, '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 0x1f45140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f455d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', '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 04:26:38 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 04:26:38 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 04:26:38 INFO - Using env: {'DISPLAY': ':0', 04:26:38 INFO - 'HOME': '/home/cltbld', 04:26:38 INFO - 'LANG': 'en_US.UTF-8', 04:26:38 INFO - 'LANGUAGE': 'en_US:en', 04:26:38 INFO - 'LOGNAME': 'cltbld', 04:26:38 INFO - 'MAIL': '/var/mail/cltbld', 04:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:38 INFO - 'MOZ_NO_REMOTE': '1', 04:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:38 INFO - 'NO_EM_RESTART': '1', 04:26:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:38 INFO - 'PWD': '/builds/slave/test', 04:26:38 INFO - 'SHELL': '/bin/bash', 04:26:38 INFO - 'SHLVL': '1', 04:26:38 INFO - 'TERM': 'linux', 04:26:38 INFO - 'TMOUT': '86400', 04:26:38 INFO - 'USER': 'cltbld', 04:26:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', 04:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:38 INFO - '_': '/tools/buildbot/bin/python'} 04:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:38 INFO - Running setup.py (path:/tmp/pip-zeDP4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:38 INFO - Running setup.py (path:/tmp/pip-Diae8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:38 INFO - Running setup.py (path:/tmp/pip-8_HSbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:38 INFO - Running setup.py (path:/tmp/pip-psIhBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:38 INFO - Running setup.py (path:/tmp/pip-496YlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:38 INFO - Running setup.py (path:/tmp/pip-M6gf7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:38 INFO - Running setup.py (path:/tmp/pip-NuXo9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:38 INFO - Running setup.py (path:/tmp/pip-iEaYkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:38 INFO - Running setup.py (path:/tmp/pip-E8sL_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:38 INFO - Running setup.py (path:/tmp/pip-HDv7lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:38 INFO - Running setup.py (path:/tmp/pip-W5_NPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:39 INFO - Running setup.py (path:/tmp/pip-u67GQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:39 INFO - Running setup.py (path:/tmp/pip-eVbi6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:39 INFO - Running setup.py (path:/tmp/pip-uFjoJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:39 INFO - Running setup.py (path:/tmp/pip-lunW_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:39 INFO - Running setup.py (path:/tmp/pip-zoUHwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:39 INFO - Running setup.py (path:/tmp/pip-BWLT05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:26:39 INFO - Running setup.py install for manifestparser 04:26:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozcrash 04:26:39 INFO - Running setup.py install for mozdebug 04:26:39 INFO - Running setup.py install for mozdevice 04:26:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozfile 04:26:40 INFO - Running setup.py install for mozhttpd 04:26:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Running setup.py install for mozinfo 04:26:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Running setup.py install for mozInstall 04:26:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Running setup.py install for mozleak 04:26:40 INFO - Running setup.py install for mozlog 04:26:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Running setup.py install for moznetwork 04:26:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Running setup.py install for mozprocess 04:26:40 INFO - Running setup.py install for mozprofile 04:26:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Running setup.py install for mozrunner 04:26:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Running setup.py install for mozscreenshot 04:26:41 INFO - Running setup.py install for moztest 04:26:41 INFO - Running setup.py install for mozversion 04:26:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:26:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:26:41 INFO - Cleaning up... 04:26:41 INFO - Return code: 0 04:26:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:41 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 0x7f224c188f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f47020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd92e0>, '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 0x1f45140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f455d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', '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 04:26:41 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 04:26:41 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 04:26:41 INFO - Using env: {'DISPLAY': ':0', 04:26:41 INFO - 'HOME': '/home/cltbld', 04:26:41 INFO - 'LANG': 'en_US.UTF-8', 04:26:41 INFO - 'LANGUAGE': 'en_US:en', 04:26:41 INFO - 'LOGNAME': 'cltbld', 04:26:41 INFO - 'MAIL': '/var/mail/cltbld', 04:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:41 INFO - 'MOZ_NO_REMOTE': '1', 04:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:41 INFO - 'NO_EM_RESTART': '1', 04:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:41 INFO - 'PWD': '/builds/slave/test', 04:26:41 INFO - 'SHELL': '/bin/bash', 04:26:41 INFO - 'SHLVL': '1', 04:26:41 INFO - 'TERM': 'linux', 04:26:41 INFO - 'TMOUT': '86400', 04:26:41 INFO - 'USER': 'cltbld', 04:26:41 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', 04:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:41 INFO - '_': '/tools/buildbot/bin/python'} 04:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:41 INFO - Running setup.py (path:/tmp/pip-McnkBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:41 INFO - Running setup.py (path:/tmp/pip-70Ky2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:41 INFO - Running setup.py (path:/tmp/pip-nMEsoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:41 INFO - Running setup.py (path:/tmp/pip-v9dUEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:41 INFO - Running setup.py (path:/tmp/pip-CL4Ksf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:41 INFO - Running setup.py (path:/tmp/pip-ew9zi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:41 INFO - Running setup.py (path:/tmp/pip-r2eL2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:42 INFO - Running setup.py (path:/tmp/pip-icKXnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:42 INFO - Running setup.py (path:/tmp/pip-AeFVec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:42 INFO - Running setup.py (path:/tmp/pip-quKtWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:42 INFO - Running setup.py (path:/tmp/pip-J1LyRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:42 INFO - Running setup.py (path:/tmp/pip-_lYzAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:42 INFO - Running setup.py (path:/tmp/pip-_Tau33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:42 INFO - Running setup.py (path:/tmp/pip-FH92k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:42 INFO - Running setup.py (path:/tmp/pip-oQRdII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:42 INFO - Running setup.py (path:/tmp/pip-T6M30W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:42 INFO - Running setup.py (path:/tmp/pip-oH13UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:42 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)) 04:26:42 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)) 04:26:42 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)) 04:26:42 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)) 04:26:42 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)) 04:26:42 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)) 04:26:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:44 INFO - Downloading blessings-1.6.tar.gz 04:26:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:44 INFO - Installing collected packages: blessings 04:26:44 INFO - Running setup.py install for blessings 04:26:44 INFO - Successfully installed blessings 04:26:44 INFO - Cleaning up... 04:26:44 INFO - Return code: 0 04:26:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:45 INFO - Reading from file tmpfile_stdout 04:26:45 INFO - Current package versions: 04:26:45 INFO - argparse == 1.2.1 04:26:45 INFO - blessings == 1.6 04:26:45 INFO - blobuploader == 1.2.4 04:26:45 INFO - docopt == 0.6.1 04:26:45 INFO - functools32 == 3.2.3-2 04:26:45 INFO - jsonschema == 2.5.1 04:26:45 INFO - manifestparser == 1.1 04:26:45 INFO - mozInstall == 1.12 04:26:45 INFO - mozcrash == 0.17 04:26:45 INFO - mozdebug == 0.1 04:26:45 INFO - mozdevice == 0.48 04:26:45 INFO - mozfile == 1.2 04:26:45 INFO - mozhttpd == 0.7 04:26:45 INFO - mozinfo == 0.9 04:26:45 INFO - mozleak == 0.1 04:26:45 INFO - mozlog == 3.2 04:26:45 INFO - moznetwork == 0.27 04:26:45 INFO - mozprocess == 0.22 04:26:45 INFO - mozprofile == 0.28 04:26:45 INFO - mozrunner == 6.11 04:26:45 INFO - mozscreenshot == 0.1 04:26:45 INFO - mozsystemmonitor == 0.3 04:26:45 INFO - moztest == 0.7 04:26:45 INFO - mozversion == 1.4 04:26:45 INFO - psutil == 3.1.1 04:26:45 INFO - requests == 1.2.3 04:26:45 INFO - wsgiref == 0.1.2 04:26:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 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 0x7f224c188f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f47020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd92e0>, '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 0x1f45140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f455d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', '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 04:26:45 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 04:26:45 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 04:26:45 INFO - Using env: {'DISPLAY': ':0', 04:26:45 INFO - 'HOME': '/home/cltbld', 04:26:45 INFO - 'LANG': 'en_US.UTF-8', 04:26:45 INFO - 'LANGUAGE': 'en_US:en', 04:26:45 INFO - 'LOGNAME': 'cltbld', 04:26:45 INFO - 'MAIL': '/var/mail/cltbld', 04:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:45 INFO - 'MOZ_NO_REMOTE': '1', 04:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:45 INFO - 'NO_EM_RESTART': '1', 04:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:45 INFO - 'PWD': '/builds/slave/test', 04:26:45 INFO - 'SHELL': '/bin/bash', 04:26:45 INFO - 'SHLVL': '1', 04:26:45 INFO - 'TERM': 'linux', 04:26:45 INFO - 'TMOUT': '86400', 04:26:45 INFO - 'USER': 'cltbld', 04:26:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', 04:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:45 INFO - '_': '/tools/buildbot/bin/python'} 04:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:45 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)) 04:26:45 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)) 04:26:45 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)) 04:26:45 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)) 04:26:45 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)) 04:26:45 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)) 04:26:45 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)) 04:26:45 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)) 04:26:45 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)) 04:26:45 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)) 04:26:45 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)) 04:26:45 INFO - Cleaning up... 04:26:45 INFO - Return code: 0 04:26:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 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 0x7f224c188f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f47020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd92e0>, '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 0x1f45140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f455d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', '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 04:26:45 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 04:26:45 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 04:26:45 INFO - Using env: {'DISPLAY': ':0', 04:26:45 INFO - 'HOME': '/home/cltbld', 04:26:45 INFO - 'LANG': 'en_US.UTF-8', 04:26:45 INFO - 'LANGUAGE': 'en_US:en', 04:26:45 INFO - 'LOGNAME': 'cltbld', 04:26:45 INFO - 'MAIL': '/var/mail/cltbld', 04:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:45 INFO - 'MOZ_NO_REMOTE': '1', 04:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:45 INFO - 'NO_EM_RESTART': '1', 04:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:45 INFO - 'PWD': '/builds/slave/test', 04:26:45 INFO - 'SHELL': '/bin/bash', 04:26:45 INFO - 'SHLVL': '1', 04:26:45 INFO - 'TERM': 'linux', 04:26:45 INFO - 'TMOUT': '86400', 04:26:45 INFO - 'USER': 'cltbld', 04:26:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', 04:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:45 INFO - '_': '/tools/buildbot/bin/python'} 04:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:26:45 INFO - Cleaning up... 04:26:45 INFO - Return code: 0 04:26:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 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 0x7f224c188f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f47020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd92e0>, '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 0x1f45140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f455d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', '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 04:26:45 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 04:26:45 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 04:26:45 INFO - Using env: {'DISPLAY': ':0', 04:26:45 INFO - 'HOME': '/home/cltbld', 04:26:45 INFO - 'LANG': 'en_US.UTF-8', 04:26:45 INFO - 'LANGUAGE': 'en_US:en', 04:26:45 INFO - 'LOGNAME': 'cltbld', 04:26:45 INFO - 'MAIL': '/var/mail/cltbld', 04:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:45 INFO - 'MOZ_NO_REMOTE': '1', 04:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:45 INFO - 'NO_EM_RESTART': '1', 04:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:45 INFO - 'PWD': '/builds/slave/test', 04:26:45 INFO - 'SHELL': '/bin/bash', 04:26:45 INFO - 'SHLVL': '1', 04:26:45 INFO - 'TERM': 'linux', 04:26:45 INFO - 'TMOUT': '86400', 04:26:45 INFO - 'USER': 'cltbld', 04:26:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', 04:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:45 INFO - '_': '/tools/buildbot/bin/python'} 04:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:45 INFO - Downloading/unpacking flake8 04:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:26:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:26:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:26:48 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 04:26:48 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 04:26:48 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 04:26:48 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 04:26:48 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 04:26:48 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 04:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:26:48 INFO - no previously-included directories found matching 'docs/_build' 04:26:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:26:48 INFO - Running setup.py install for pep8 04:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:26:48 INFO - no previously-included directories found matching 'docs/_build' 04:26:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:26:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:26:48 INFO - Cleaning up... 04:26:48 INFO - Return code: 0 04:26:48 INFO - Running post-action listener: _resource_record_post_action 04:26:48 INFO - Running post-action listener: _start_resource_monitoring 04:26:48 INFO - Starting resource monitoring. 04:26:48 INFO - ##### 04:26:48 INFO - ##### Finished create-virtualenv step (success) 04:26:48 INFO - ##### 04:26:48 INFO - ##### 04:26:48 INFO - ##### Running install step. 04:26:48 INFO - ##### 04:26:48 INFO - Running pre-action listener: _resource_record_pre_action 04:26:48 INFO - Running main action method: install 04:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:48 INFO - Reading from file tmpfile_stdout 04:26:48 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:48 INFO - Reading from file tmpfile_stdout 04:26:48 INFO - Output received: 04:26:48 INFO - Usage: mozinstall [options] installer 04:26:48 INFO - Options: 04:26:48 INFO - -h, --help show this help message and exit 04:26:48 INFO - -d DEST, --destination=DEST 04:26:48 INFO - Directory to install application into. [default: 04:26:48 INFO - "/builds/slave/test"] 04:26:48 INFO - --app=APP Application being installed. [default: firefox] 04:26:48 INFO - mkdir: /builds/slave/test/build/application 04:26:48 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'] 04:26:48 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 04:27:04 INFO - Reading from file tmpfile_stdout 04:27:04 INFO - Output received: 04:27:04 INFO - /builds/slave/test/build/application/firefox/firefox 04:27:04 INFO - Running post-action listener: _resource_record_post_action 04:27:04 INFO - ##### 04:27:04 INFO - ##### Finished install step (success) 04:27:04 INFO - ##### 04:27:04 INFO - ##### 04:27:04 INFO - ##### Running run-tests step. 04:27:04 INFO - ##### 04:27:04 INFO - Running pre-action listener: _resource_record_pre_action 04:27:04 INFO - Running main action method: run_tests 04:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:04 INFO - Python 2.7.3 04:27:04 INFO - Return code: 0 04:27:04 INFO - grabbing minidump binary from tooltool 04:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:04 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 0x1fd92e0>, '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 0x1f45140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f455d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27:04 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 04:27:04 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 04:27:04 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 04:27:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:05 INFO - Return code: 0 04:27:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:27:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:27:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:27:05 INFO - Return code: 0 04:27:05 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/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 04:27:05 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/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 04:27:05 INFO - Using env: {'DISPLAY': ':0', 04:27:05 INFO - 'HOME': '/home/cltbld', 04:27:05 INFO - 'LANG': 'en_US.UTF-8', 04:27:05 INFO - 'LANGUAGE': 'en_US:en', 04:27:05 INFO - 'LOGNAME': 'cltbld', 04:27:05 INFO - 'MAIL': '/var/mail/cltbld', 04:27:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:05 INFO - 'MOZ_NO_REMOTE': '1', 04:27:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:05 INFO - 'NO_EM_RESTART': '1', 04:27:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:05 INFO - 'PWD': '/builds/slave/test', 04:27:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:05 INFO - 'SHELL': '/bin/bash', 04:27:05 INFO - 'SHLVL': '1', 04:27:05 INFO - 'TERM': 'linux', 04:27:05 INFO - 'TMOUT': '86400', 04:27:05 INFO - 'USER': 'cltbld', 04:27:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154', 04:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:05 INFO - '_': '/tools/buildbot/bin/python'} 04:27:05 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/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 04:27:06 INFO - mozversion application_buildid: 20160614031626 04:27:06 INFO - mozversion application_changeset: a00cf073f5c00380d4e42b13bc0cd3146b708845 04:27:06 INFO - mozversion application_display_name: Nightly 04:27:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:06 INFO - mozversion application_name: Firefox 04:27:06 INFO - mozversion application_remotingname: firefox 04:27:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:27:06 INFO - mozversion application_vendor: Mozilla 04:27:06 INFO - mozversion application_version: 50.0a1 04:27:06 INFO - mozversion platform_buildid: 20160614031626 04:27:06 INFO - mozversion platform_changeset: a00cf073f5c00380d4e42b13bc0cd3146b708845 04:27:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:27:06 INFO - mozversion platform_version: 50.0a1 04:27:06 INFO - using testdate: 1465903626 04:27:06 INFO - actual date: 1465903626 04:27:06 INFO - starting webserver on 'localhost:49557' 04:27:06 INFO - SUITE-START | Running 2 tests 04:27:06 INFO - TEST-START | dromaeo_css 04:27:06 INFO - operating with platform_type : linux_ 04:27:06 INFO - Initialising browser for dromaeo_css test... 04:27:06 INFO - TEST-INFO | started process 25538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGDTnNf/profile http://localhost:49557/getInfo.html) 04:27:11 INFO - PROCESS | 25538 | __metrics Screen width/height:1600/1200 04:27:11 INFO - PROCESS | 25538 | colorDepth:24 04:27:11 INFO - PROCESS | 25538 | Browser inner width/height: 1024/697 04:27:11 INFO - PROCESS | 25538 | __metrics 04:27:11 ERROR - PROCESS | 25538 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:27:12 INFO - TEST-INFO | 25538: exit 0 04:27:12 INFO - Browser initialized. 04:27:12 INFO - Running cycle 1/1 for dromaeo_css test... 04:27:12 INFO - TEST-INFO | started process 25656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGDTnNf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:25 INFO - PROCESS | 25656 | RSS: Main: 186007552 04:27:25 INFO - PROCESS | 25656 | 04:28:14 INFO - PROCESS | 25656 | 1465903694604 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] 04:30:26 INFO - PROCESS | 25656 | Cycle 1(1): loaded http://localhost:49557/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49557/tests/dromaeo/cssquery-ext.html) 04:30:27 INFO - PROCESS | 25656 | RSS: Main: 189272064 04:30:27 INFO - PROCESS | 25656 | 04:33:29 INFO - PROCESS | 25656 | Cycle 1(1): loaded http://localhost:49557/tests/dromaeo/cssquery-ext.html (next: http://localhost:49557/tests/dromaeo/cssquery-jquery.html) 04:33:30 INFO - PROCESS | 25656 | RSS: Main: 188162048 04:33:30 INFO - PROCESS | 25656 | 04:36:32 INFO - PROCESS | 25656 | Cycle 1(1): loaded http://localhost:49557/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49557/tests/dromaeo/cssquery-mootools.html) 04:36:33 INFO - PROCESS | 25656 | RSS: Main: 189988864 04:36:33 INFO - PROCESS | 25656 | 04:39:34 INFO - PROCESS | 25656 | Cycle 1(1): loaded http://localhost:49557/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49557/tests/dromaeo/cssquery-prototype.html) 04:39:35 INFO - PROCESS | 25656 | RSS: Main: 186744832 04:39:35 INFO - PROCESS | 25656 | 04:42:38 INFO - PROCESS | 25656 | Cycle 1(1): loaded http://localhost:49557/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49557/tests/dromaeo/cssquery-yui.html) 04:42:38 INFO - PROCESS | 25656 | RSS: Main: 188092416 04:42:38 INFO - PROCESS | 25656 | 04:45:41 INFO - PROCESS | 25656 | Cycle 1(1): loaded http://localhost:49557/tests/dromaeo/cssquery-yui.html (next: http://localhost:49557/tests/dromaeo/cssquery-dojo.html) 04:45:41 INFO - PROCESS | 25656 | RSS: Main: 189870080 04:45:41 INFO - PROCESS | 25656 | 04:45:41 INFO - PROCESS | 25656 | __start_tp_report 04:45:41 INFO - PROCESS | 25656 | _x_x_mozilla_page_load 04:45:41 INFO - PROCESS | 25656 | _x_x_mozilla_page_load_details 04:45:41 INFO - PROCESS | 25656 | |i|pagename|runs| 04:45:41 INFO - PROCESS | 25656 | |0;dojo.html;2620.554505734025;2677.8928842846285;2682.10149599884;2685.140754958414;2697.7437143471375;4705.976470117645;4767.308740232668;4805.3993250843605;4848.806047758094;4873.317735517022;4636.350910872472;4821.951780482194;4833.154198015351;4877.951220487794;4923.040007198598;4426.690131690775;4446.1107778444275;4541.137183935041;4542.977829988259;4569.702969306984;548.9616683888702;4309.987153019038;4405.140997505488;4416.624586910117;4426.424564806571;4425.867223983286;4435.977820110895;4446.466424029105;4449.0879369729455;4517.141743068806;4460.085682435093;4471.776411179428;4478.216312145361;4479.17135329965;4533.84131555394;4291.249031419489;4414.624756895668;4428.822847086113;4454.465464144291;4462.062966776981;4765.833195838164;4804.111239420718;4848.054629347279;4848.345473361086;4909.631777616693;4941.332920055783;5179.145441002268;5184.300119483859;5199.558037566811;5256.080185967478;5082.720450375228;5114.590832733373;5123.359580052494;5148.56237219833;5152.201408781645;4809.807607695688;4816.084943860656;4817.0365926814775;4829.1307564638;4866.0024694938165;5234.633575649744;5253.212018197224;5261.868453288698;5286.101362768339;5320.973395133077;5123.97438012815;5127;5128.564072053842;5137.974310128426;5201.531862132426;5190.792368305301;5218;5218.556422704112;5230.921536176884;5296.708681022581;4921.606271498272;5110.310108135429;5140.922886156711;5161.458046905096;5174.249733788655;5141.331626888556;5148.3564554430695;5152.819651312261;5182.32629758129;5186.974065129726;4358.564143585616;4358.825646974085;4363.4763828340165;4379.781010949439;4416.933745993812;3736.3648179809497;3762.6801721853403;3808.8857334280015;3823.6749876260274;3827.9808600956817;4289.678274129453;4455.888602784957;4476.037651904856;4502.527234640315;4544.0457503924545;5237.162054071407;5247.02929957959;5252.185911183773;5263.815766448156;5317.069512835238;4305.956940430556;4357.891052723708;4437.112577484516;4489.349044388546;4541.613962813198;4636.605888499448;4643.8374656886845;4665.6734028617675;4677.298405239241;4679.742614156254;4770.141374552614;4844.370231869834;4851.733154676456;4855.830045948375;4930.186519224288;5004.649674522749;5063.392392912727;5063.468335824833;5114.130597798308;5206.401263854554;4795.944892123727;4798.856034318976;4876.829310974099;4882;4940.6788558743565;5135.127028405105;5135.717535535581;5144.202648589475;5154.122752634842;5169.7673604687125;5255.947440525699;5258.053550360972;5260.631755777059;5263.921041184309;5315.415304316445;4898.657094003385;4986.975065124651;5047.217681259411;5068.163752980864;5071.644984851025;5024.497550244946;5046.747662616781;5076.974615126901;5091.516305950929;5138.409082955508;4750.239961606127;4902.264660300983;4914.533119353656;4943.110240156662;4944.505549445027;5055.292259083658;5082.2122571001555;5112.36095488064;5137.152369858932;5145;4973.154563724248;4977.104121258063;4982.701037937735;5019.372578427697;5033.320501732219 04:45:41 INFO - PROCESS | 25656 | |1;ext.html;586.8884911866745;588.7115313496386;606.5966132521874;628.9182406287182;645.5932762359713;32226.35547289056;32944.505832412506;35297.29405411893;35635.10912227189;35676.2864742705;36193.63806361942;36916.07709807249;36968.81515592425;36972.63027369726;37041.259174816485;7560.508566943145;7719.884201736979;7737.690492380298;7745.109312429058;7775.377969762434;7633.313001829834;7673.3861291096855;7680.923190768077;7686.116096648873;7698.384129269645;7694;7731.0336207974005;7736.381089512825;7754.1470438251745;7756.069271687377;7675.769726908202;7701.22987701231;7734.961325193338;7757.728479503218;7760;7551.697932082765;7661.195574464712;7665.8850117248285;7682.539047657158;7684.193159718261;24785.87607061953;24892.875535622206;24912.37719057038;24935;25117;2388.1402695029774;2796.3987742635227;3133.9529907051415;3290.6215785184772;3738.327101121797;27562.44875102507;27856;27877.606119694137;28159.15522534327;28733.856330718423;3335.7831740937004;3356.647552007053;3419.384510788057;3445.0526105320987;3492.0746002309406;220912;221579;222439.99999999837;222491;223465;30938.215560599205;31101;31420.84289578583;32006.35987280288;32268.677313226566;33642.32715345679;33671.15822104467;33702.65189392397;33806.66193338084;33876.49185262174;12927.806082908764;12943.482260709654;12998.090133690741;13104.2137471752;13116.278604676834;9447;9560.378575392577;9599.760005999906;9603.711888643353;9612.134907858326;7755.573443460664;7806.102298235775;7839;7849.254320839511;7914.24814642608;3071.1400807773857;3103.34829685764;3120.2511397264493;3125.6249250090136;3151.842407879597;846.348311799923;896.2231307132965;899.7255836969787;950.1306304731231;989.5200827598753;27044.864775675996;27880.16359509218;28030.579541306488;28111.57832632512;28439.146825595264;924.5562130177552;972.2756546372998;997.6558087459815;1014.102519270451;1053.8261186904074;14542.927285363718;14674.633134171518;14878.553643390716;14891;15162.166080865438;395688;397320;402848;403312;403411;33137.66862331394;33208.3358332832;33250;33305.50041749376;33368.833155834065;1174.5536696055615;1182.6097387861985;1203.778165162361;1219.4939100273286;1229.2624425344723;26321;27748.722512774613;28028.29929251785;28051.579226311213;28058.43883122285;41837.58162418459;41943.7902810484;42333.5766642342;42394.78802605967;42409.78795106005;332471;332885;333158;334924;335767;24923.376915577257;25274;25293.62059569145;25368.746312537376;25415;39119.60880391159;40411.1917761649;41282.38076428916;41492.170156597305;42337.364939526546;35460.82269588635;35799.64200357963;35967;36402.63597364099;36435.45346819747;34458.655413445544;35759.46360804538;35927;35985.640143599274;36020.45969310515;33534.32931341311;34966.30067398689;35069.47395789014;35129.473057904666;35316.823415882754;31043.068707938797;32296.674480512374;32471;32543.34913301768;32751.18122046968;25383.238502844943;25430.618540721534;25461.618075728507;25769.742302576735;25919.35201619899 04:45:41 INFO - PROCESS | 25656 | |2;jquery.html;364.81941438987695;369.2135750850688;372.6068997207948;381.8701641441911;382.74164938666394;15736.527904162878;17280.48158555244;18159.364422245224;18238.361657341997;18241.817581824176;11800.232984855978;15693.21533923305;16596.66806663866;16597.41909033184;17385.565360865985;4579.725216487013;4728.078024785168;4755.144074066667;4759.595434388081;4761.523847615245;3484.6689564491335;4649.93025104622;5112.105381558231;5388.218708287296;5391.353037635489;5452.863678408052;5463.726813659321;5487.122060470326;5504.4495550445035;5524.944750552483;5346.224797404393;5386.596005299599;5391.056565101092;5416.756245968922;5482.506574408322;5214.921776173361;5269.894602107975;5272.894542109137;5279.70961597112;5289.894202115975;11720.765584688344;12472.875271247261;12531.624051278477;12542.81185782214;12589.30758808265;1807.2499912536282;1946.6106778644328;2061.5258490547108;2331.80179684727;2379.3337865397716;9268.16586507211;9417.152456278967;9732.318737688365;12587.74824503514;13036.41336139876;1695.4913525942168;1732.9759569551088;1749.7812773403325;1815.6550255451555;1868.962620747591;58347.70826145884;62234;70122.64938675275;71077.64461177713;71266.64366678185;8801;9781.853272200922;9850.80298394028;9908.315586350338;10077.344972576759;13210;13265.336733163304;13304.201747895157;13311.267880266485;13368.598942031755;6720.6639668016405;7066.328698773608;7145.249748776304;7188.964055179691;7249.130104387507;6613;6632.568883022588;6677.23211830636;6680.0981867448245;6692.431143352772;4104.302268614343;4147.19129769692;4382.342648602735;4460.843870464518;4487.775611219426;1651.2981982657564;1718.2611477064731;1798.8740788144705;1824.087956021989;1853.7312089747181;785.4619585583779;839.8782176584361;891.416122439803;913.0777914306598;960.5341409416427;15690.686186276438;16644.750328745078;16737.808821627234;17153.485395438158;17221.655566888592;834.1732995029713;835.6782638684028;846.593635055177;864.9956750216209;879.1647934462286;9490.145886870216;9674.322797404255;9743.561539730728;9813.411195328303;9889.307748457539;409566;412743;421179;425450;425984;76462;80529.59735201286;80626;82342.58828705818;83246.58376708078;858.2704701004221;881.8089907035263;894.0344428017726;898.3352319283814;898.9730308090768;15448.227588620748;15513;15549.378024878879;15563.144027078166;15672.373105075669;36429.81785091058;36847;37827.62172378241;38123;38801.6119838798;53190.46809531855;53608;53728.194077089654;53823.73088134534;54271;7495.88756168647;7511.699532018658;7584.886226706714;7616.3906887449975;7654.961725191339;10759.46202689878;10788.298760580537;11049.613263535737;11172.547568816002;11222.382768947786;9701.369410988264;10121.190304775453;10264.64073757415;10283.177345812466;10313.587456501657;10040.949795251268;10048.748781280527;10056.094951454405;10228.48857557134;10280.383177009404;9678.516074196403;9819.263555233529;10278.743031424274;10510.31682940637;10606.257561970588;7288.2648863981885;7390.6674199660065;7544;7641.159472458136;7682.692692292246;7578.658960346908;8986.550672466481;9642.807143856944;10210.948945255226;10243.692689219335 04:45:41 INFO - PROCESS | 25656 | |3;mootools.html;1376.71089071295;1409.6475881029742;1494;1668.8915220510657;1669.5492217101382;7080.468964827633;7641.465097443182;7819.530828150315;8123.431359804808;8126.146754590772;7891.723789667363;8097.2712455878955;8164.1835816418325;8168.101508834024;8171.019477662674;2248.325502349293;2260.7739226077424;2280.9201677941273;2281.4068342231058;2286.2912497125863;2240.932772016842;2242.517858660388;2250.7524172341027;2269.273832373641;2278.134308962592;2230.6765518999737;2232.7767223277706;2244.708187935574;2250.763669814662;2282.018731945263;2200.141944641591;2202.2292197730826;2209.834262430316;2223.4219103033165;2226.543558570489;2109.040386624082;2123.341764053133;2126.1176611706123;2159.427751645815;2165.7076294700173;8155.143709910492;8186.918130818675;8202.138775428613;8214.1375155609;8290.253877151084;4707.952920470786;4814.9518504815205;4826.903461930741;4833.250846118857;4852.975735121302;3006.8573941902155;3070.3398769264713;3089.3203495231014;3116.439040972624;3167.509036099408;952.7951490429522;986.6349450703286;997.7206382212992;1001.5993602558962;1002.5488530161457;11080.168987325982;11171.608993685264;11173;11178;11187;4306.160298741778;4316.611504964505;4417.315316126005;4487.259602165672;4489.820407183676;9357.532123393803;9376.718698439057;9396.906030939603;9399.389039712396;9416.340856140005;4725.102230576248;4753.572178503882;4755;4759.38128043359;4773.212419950739;3782.111203867089;4200.390943313202;4236.068065025689;4324.56754324565;4364.236258654722;3726.8509259629855;3751.8369305515375;3825.12022234882;3833.4824798651825;3969.900752481153;1183.3432444993111;1231.58741821489;1231.6736064942797;1238.0590751029283;1259.3640211693219;788.9013873265842;792.7899106736719;809.9228026724443;821.2977903892087;847.51268020887;5310.654807437504;5335.039692855245;5411.647088227943;5449.482299181572;5456.59075569326;891.2290868398918;894.8165626046645;912.2884150362728;929.2333824594737;930.06993006993;3533.0990597398013;3690.55713314404;3728.067983004249;3742.7941463219786;3763.040424691741;9720.125188733047;9977.301588888853;9994.050565196294;10117.038881306264;10124.746881328027;9971.252156088321;10058.094771470604;10058.597656093674;10074.244431667654;10092;7576.81057973544;7637.4653774236385;7638.961805190938;7712.074551053909;7760.805979850436;5459.399466058651;5461.672299662033;5466.180072988925;5529.889402211853;5563.944360556343;9237.630494780133;9243.260539156718;9289.814203716023;9383.624655013722;9474;9360.4383736976;9424.434533927986;9458.29062820305;9495;9511.334206605472;5922.822315330547;6275.937240627535;6374.553781235269;6442.452391546583;6488.091667166695;7527.924720752722;7580.9620951894885;7628.961855190689;7648;7670.117936437381;6585.440237579859;6735.6295403753265;6835.658217089026;6858.279880612663;6876.002979568035;6613.43785778195;6638.933610664025;6669.266380698023;6781.3896749290825;6806.081179040766;6254.249490061222;6574.474042076718;6716.059751634677;6719.496037797087;6723.394894459522;4619.168549660959;4667.509911459248;4702.412198475191;4826.541478559531;4846.103470857903;4764.78558464863;4885.2427873679635;4886.780094895809;4948.950510494849;5036.143855544639 04:45:41 INFO - PROCESS | 25656 | |4;prototype.html;299.50731047426984;304.7257468278549;305.0452084974031;309.23927139237475;311.12728795727975;5165.870853228671;5170.379554453466;5178.508041736034;5180.627133809544;5197.584193264539;5078.949210507893;5086.160783470723;5097.209932460474;5101;5109.565686916617;3813.3326667833157;3897.883063508085;3957.3866050762176;3987.6411122998925;3990.720649554518;3932.803359832011;3983.1237127831973;3996.582067848953;4002.4790579579717;4004.3793212052033;3974.761514309136;3979.8408063677416;3986.1429792594586;3987.9800600996955;3988.720789544733;3713.7771733696063;3938.5864484229314;3941.783201923893;4007.3788562772816;4020.1758639478985;3408.8466019028956;3418.5555877735737;3428.708559772422;3436.914077148066;3437.2781715839706;4924.719572911069;4935.3090567320605;4960.479149689267;4961.603071754251;4963.751812409365;4192.958070419288;4470.061287129706;4485.407680273489;4486.842960496399;4490.39379683745;5262.60530460217;5283.392409872876;5291.894162116774;5295.523402893758;5303.655262407931;3731.477593136963;3732.869349572752;3737.4767532545466;3755.1926335837925;3756.455313979485;5262.8684282892855;5530.2810634617645;5584.21820945068;5600.5519558435635;5603.215549823028;3806.600306967784;3814.885553433346;3818.537043606858;3842.481265029241;3852.287326844543;3872.9031774205305;3878.1080351518744;3893.96106038936;3898.590647981978;3910.9804450977563;4470.463544374696;4478.678789757029;4485.887852803706;4494.483134439516;4497.955020449819;5206.869828254324;5244.29202057725;5251.684898906078;5284.339457567804;5382.838514844561;1299.8960083193322;1316.414195682912;1319;1325.4896864706964;1330.9068365214341;815.9840997957581;826.9049059358131;830.9916900830914;833.470746076246;872.4808738800403;4647.34937108805;4650.511696271843;4688.624910007191;4696.1546921554445;4708.199606066908;5425.620206585501;5443.237946687467;5445.413428621452;5446.400895901447;5449.719315960746;4484.1255955088445;4622.2604383299185;4623.653226007996;4636.698614590041;4636.744979026119;2892.5082735934943;2909.854507274628;2910.8544572771702;2912.2137023004093;2924.400497897926;5042.042012017705;5044.8234311798915;5097.362829646294;5112.769925353368;5138.588912887035;5338.54622357104;5537.667739935617;5542.861428464321;5594.384617692051;5638.238837756932;5095.439501654815;5103.311053007871;5112.463191364853;5116.641835071509;5122.231665250242;5408.215808707637;5423.674579525241;5450.563954883679;5474.945250547444;5496.642718223303;5123.359580052494;5213.687178769286;5296.920546191887;5306.867328316823;5336.306280183551;5092.090466075222;5109.565686916654;5121.539061484485;5155.200943853709;5180.197069454241;3751.868684596026;3773.1321795987624;3783.281176576442;3783.432485127253;3848.4034974578985;5071.670341427943;5435.967166238402;5439.836804895859;5469.511372325662;5505.449455054462;5338.3060202173465;5386.218998245311;5390.137577987503;5395.136778115482;5417.458254174709;5165.380154381498;5369.248305237348;5375.919361209663;5380.811671591476;5454.727263636723;5104.41299250591;5147.94467134244;5149.948500514947;5155.43290238081;5225.425203227566;5129.461406552258;5219.217117432416;5382.623216374816;5404.7297635118875;5405.756740946588;5266.526012658879;5281.287026251407;5283.524482796567;5285.973570132125;5307.982966472716 04:45:41 INFO - PROCESS | 25656 | |5;yui.html;669.748844183431;672.9663516824161;707.1302298173249;718.6550455781224;725.9782206533806;12618.621441356763;13102.148360356594;13283.136596121258;13311.334433278322;13322;13115.54095606654;13201.735965280688;13291.335433228323;13369.465221391132;13411.664708382272;620.2587907450599;778.9844203115935;791.1811275330034;796.6932730898587;797.3023604346197;765.6554550452319;793.4604468961104;795.741384050186;797.1231645190273;802.3300544045729;835.0230230630177;847.1232274595794;847.1782371100023;847.3390755210945;850.2050582705191;836.0093289451988;836.6277006731976;838.7986883148061;839.3159574946399;843.7510934274404;605.9272887253513;608.8417011576978;609.1015751766109;609.6738245038883;613.089562000429;13060.804087938688;13084.476620935151;13086.41111149991;13098.148620339647;13117.081804273705;11803.468843902045;11954.282743035446;12597.433115509824;12823.230606163661;12983.480660773557;11793.351365674884;12149.514019439212;12223.877761222362;12588.559400421032;12619.864212220853;4153.68847336451;4207.284761590537;4216.198922204771;4225.218334608107;4239.830406783725;59513.70243148757;60187.398126019056;60625.6968715158;60735.39264607386;61269.08096378558;10251.743706407251;10276.588936442458;10397.636082737068;10438.68683939483;10778.622748203776;17002.914985424995;17141.142942852806;17214.225359858836;17328.82671173272;17950.371736989142;6631.933680663228;6758.966205168943;6839.726410943606;6868.038474613558;6925.272846351161;3597.4783656370205;3758.342290099222;3768;3857.187122052631;3878.864239751595;2781.1656503049003;3334.949975750317;3497.370473314828;3501.719862411001;3512.2799826035603;549.3243310727827;566.4562020460322;567.8807450435372;569.2031156381017;579.3048341989629;518.6602775182262;527.6781163490268;535.6652092442224;556.4102051825079;564.9491545760901;7383.520071195355;7631.275028872248;7655.2344765523;7876.448648594658;8284.08875023747;512.5617596954625;530.3389428774603;532.7043490862609;561.0294191049426;561.4469747298907;3227.5158726191257;3300.669933006728;3326.3181047885128;3418.111291064341;3421.709154721827;57500;59116.11325830116;59585.702071489366;59721.70139149277;59723;87102;90447.09552904518;91266.54366728256;91600;91978.54010729904;44821.327680084825;45195.54804451979;52702.73648631809;75789.96840126334;77502.61248693608;6348.619082855043;6372.968135159294;6430.807075787734;6436.324185960594;6493;43745.78127109344;47040.7647961758;47044.529554704015;48257.75871120622;48772.512274878216;37678.434823477124;54450;65511;65775;65885.67057164683;9296.07039296065;9532.714018579454;9543.761405964906;9789.559469823733;9859.556319965475;11131.443427828413;11217.775644487228;11303.717407064889;11332.37671928019;11787.646370608896;9467.479288639192;9658.951705241428;9687.176589989647;9689.70930872075;11526.15581506955;10121;11465.197436179387;11879.168458207843;11931.522739090338;12202.694932626755;11185.272957257752;11307.886921131012;11401.657950261506;11565.7108572283;11617.128715346214;9876.40741555509;10189.643362482277;10229.897701023192;10267.897321026694;10383.68848934503;9271.397359171633;9811.754706132118;10069.69790906274;10110.39337639744;10139.797204056025 04:45:41 INFO - PROCESS | 25656 | __end_tp_report 04:45:41 INFO - PROCESS | 25656 | __start_cc_report 04:45:41 INFO - PROCESS | 25656 | _x_x_mozilla_cycle_collect,390 04:45:41 INFO - PROCESS | 25656 | __end_cc_report 04:45:41 INFO - PROCESS | 25656 | __startTimestamp1465904741600__endTimestamp 04:45:41 INFO - PROCESS | 25656 | 04:45:41 INFO - PROCESS | 25656 | ------- Summary: start ------- 04:45:41 INFO - PROCESS | 25656 | Number of tests: 6 04:45:41 INFO - PROCESS | 25656 | 04:45:41 INFO - PROCESS | 25656 | [#0] dojo.html Cycles:165 Average:4754.30 Median:4902.26 stddev:607.92 (12.4%) stddev-sans-first:586.29 04:45:41 INFO - PROCESS | 25656 | Values: 2620.6 2677.9 2682.1 2685.1 2697.7 4706.0 4767.3 4805.4 4848.8 4873.3 4636.4 4822.0 4833.2 4878.0 4923.0 4426.7 4446.1 4541.1 4543.0 4569.7 549.0 4310.0 4405.1 4416.6 4426.4 4425.9 4436.0 4446.5 4449.1 4517.1 4460.1 4471.8 4478.2 4479.2 4533.8 4291.2 4414.6 4428.8 4454.5 4462.1 4765.8 4804.1 4848.1 4848.3 4909.6 4941.3 5179.1 5184.3 5199.6 5256.1 5082.7 5114.6 5123.4 5148.6 5152.2 4809.8 4816.1 4817.0 4829.1 4866.0 5234.6 5253.2 5261.9 5286.1 5321.0 5124.0 5127.0 5128.6 5138.0 5201.5 5190.8 5218.0 5218.6 5230.9 5296.7 4921.6 5110.3 5140.9 5161.5 5174.2 5141.3 5148.4 5152.8 5182.3 5187.0 4358.6 4358.8 4363.5 4379.8 4416.9 3736.4 3762.7 3808.9 3823.7 3828.0 4289.7 4455.9 4476.0 4502.5 4544.0 5237.2 5247.0 5252.2 5263.8 5317.1 4306.0 4357.9 4437.1 4489.3 4541.6 4636.6 4643.8 4665.7 4677.3 4679.7 4770.1 4844.4 4851.7 4855.8 4930.2 5004.6 5063.4 5063.5 5114.1 5206.4 4795.9 4798.9 4876.8 4882.0 4940.7 5135.1 5135.7 5144.2 5154.1 5169.8 5255.9 5258.1 5260.6 5263.9 5315.4 4898.7 4987.0 5047.2 5068.2 5071.6 5024.5 5046.7 5077.0 5091.5 5138.4 4750.2 4902.3 4914.5 4943.1 4944.5 5055.3 5082.2 5112.4 5137.2 5145.0 4973.2 4977.1 4982.7 5019.4 5033.3 04:45:41 INFO - PROCESS | 25656 | 04:45:41 INFO - PROCESS | 25656 | [#1] ext.html Cycles:180 Average:44567.76 Median:18647.94 stddev:86667.13 (464.8%) stddev-sans-first:86847.35 04:45:41 INFO - PROCESS | 25656 | Values: 586.9 588.7 606.6 628.9 645.6 32226.4 32944.5 35297.3 35635.1 35676.3 36193.6 36916.1 36968.8 36972.6 37041.3 7560.5 7719.9 7737.7 7745.1 7775.4 7633.3 7673.4 7680.9 7686.1 7698.4 7694.0 7731.0 7736.4 7754.1 7756.1 7675.8 7701.2 7735.0 7757.7 7760.0 7551.7 7661.2 7665.9 7682.5 7684.2 24785.9 24892.9 24912.4 24935.0 25117.0 2388.1 2796.4 3134.0 3290.6 3738.3 27562.4 27856.0 27877.6 28159.2 28733.9 3335.8 3356.6 3419.4 3445.1 3492.1 220912.0 221579.0 222440.0 222491.0 223465.0 30938.2 31101.0 31420.8 32006.4 32268.7 33642.3 33671.2 33702.7 33806.7 33876.5 12927.8 12943.5 12998.1 13104.2 13116.3 9447.0 9560.4 9599.8 9603.7 9612.1 7755.6 7806.1 7839.0 7849.3 7914.2 3071.1 3103.3 3120.3 3125.6 3151.8 846.3 896.2 899.7 950.1 989.5 27044.9 27880.2 28030.6 28111.6 28439.1 924.6 972.3 997.7 1014.1 1053.8 14542.9 14674.6 14878.6 14891.0 15162.2 395688.0 397320.0 402848.0 403312.0 403411.0 33137.7 33208.3 33250.0 33305.5 33368.8 1174.6 1182.6 1203.8 1219.5 1229.3 26321.0 27748.7 28028.3 28051.6 28058.4 41837.6 41943.8 42333.6 42394.8 42409.8 332471.0 332885.0 333158.0 334924.0 335767.0 24923.4 25274.0 25293.6 25368.7 25415.0 39119.6 40411.2 41282.4 41492.2 42337.4 35460.8 35799.6 35967.0 36402.6 36435.5 34458.7 35759.5 35927.0 35985.6 36020.5 33534.3 34966.3 35069.5 35129.5 35316.8 31043.1 32296.7 32471.0 32543.3 32751.2 25383.2 25430.6 25461.6 25769.7 25919.4 04:45:41 INFO - PROCESS | 25656 | 04:45:41 INFO - PROCESS | 25656 | [#2] jquery.html Cycles:180 Average:24918.16 Median:4741.61 stddev:69136.81 (1458.1%) stddev-sans-first:69306.17 04:45:41 INFO - PROCESS | 25656 | Values: 364.8 369.2 372.6 381.9 382.7 15736.5 17280.5 18159.4 18238.4 18241.8 11800.2 15693.2 16596.7 16597.4 17385.6 4579.7 4728.1 4755.1 4759.6 4761.5 3484.7 4649.9 5112.1 5388.2 5391.4 5452.9 5463.7 5487.1 5504.4 5524.9 5346.2 5386.6 5391.1 5416.8 5482.5 5214.9 5269.9 5272.9 5279.7 5289.9 11720.8 12472.9 12531.6 12542.8 12589.3 1807.2 1946.6 2061.5 2331.8 2379.3 9268.2 9417.2 9732.3 12587.7 13036.4 1695.5 1733.0 1749.8 1815.7 1869.0 58347.7 62234.0 70122.6 71077.6 71266.6 8801.0 9781.9 9850.8 9908.3 10077.3 13210.0 13265.3 13304.2 13311.3 13368.6 6720.7 7066.3 7145.2 7189.0 7249.1 6613.0 6632.6 6677.2 6680.1 6692.4 4104.3 4147.2 4382.3 4460.8 4487.8 1651.3 1718.3 1798.9 1824.1 1853.7 785.5 839.9 891.4 913.1 960.5 15690.7 16644.8 16737.8 17153.5 17221.7 834.2 835.7 846.6 865.0 879.2 9490.1 9674.3 9743.6 9813.4 9889.3 409566.0 412743.0 421179.0 425450.0 425984.0 76462.0 80529.6 80626.0 82342.6 83246.6 858.3 881.8 894.0 898.3 899.0 15448.2 15513.0 15549.4 15563.1 15672.4 36429.8 36847.0 37827.6 38123.0 38801.6 53190.5 53608.0 53728.2 53823.7 54271.0 7495.9 7511.7 7584.9 7616.4 7655.0 10759.5 10788.3 11049.6 11172.5 11222.4 9701.4 10121.2 10264.6 10283.2 10313.6 10040.9 10048.7 10056.1 10228.5 10280.4 9678.5 9819.3 10278.7 10510.3 10606.3 7288.3 7390.7 7544.0 7641.2 7682.7 7578.7 8986.6 9642.8 10210.9 10243.7 04:45:41 INFO - PROCESS | 25656 | 04:45:41 INFO - PROCESS | 25656 | [#3] mootools.html Cycles:180 Average:5304.03 Median:4917.87 stddev:2982.31 (60.6%) stddev-sans-first:2976.08 04:45:41 INFO - PROCESS | 25656 | Values: 1376.7 1409.6 1494.0 1668.9 1669.5 7080.5 7641.5 7819.5 8123.4 8126.1 7891.7 8097.3 8164.2 8168.1 8171.0 2248.3 2260.8 2280.9 2281.4 2286.3 2240.9 2242.5 2250.8 2269.3 2278.1 2230.7 2232.8 2244.7 2250.8 2282.0 2200.1 2202.2 2209.8 2223.4 2226.5 2109.0 2123.3 2126.1 2159.4 2165.7 8155.1 8186.9 8202.1 8214.1 8290.3 4708.0 4815.0 4826.9 4833.3 4853.0 3006.9 3070.3 3089.3 3116.4 3167.5 952.8 986.6 997.7 1001.6 1002.5 11080.2 11171.6 11173.0 11178.0 11187.0 4306.2 4316.6 4417.3 4487.3 4489.8 9357.5 9376.7 9396.9 9399.4 9416.3 4725.1 4753.6 4755.0 4759.4 4773.2 3782.1 4200.4 4236.1 4324.6 4364.2 3726.9 3751.8 3825.1 3833.5 3969.9 1183.3 1231.6 1231.7 1238.1 1259.4 788.9 792.8 809.9 821.3 847.5 5310.7 5335.0 5411.6 5449.5 5456.6 891.2 894.8 912.3 929.2 930.1 3533.1 3690.6 3728.1 3742.8 3763.0 9720.1 9977.3 9994.1 10117.0 10124.7 9971.3 10058.1 10058.6 10074.2 10092.0 7576.8 7637.5 7639.0 7712.1 7760.8 5459.4 5461.7 5466.2 5529.9 5563.9 9237.6 9243.3 9289.8 9383.6 9474.0 9360.4 9424.4 9458.3 9495.0 9511.3 5922.8 6275.9 6374.6 6442.5 6488.1 7527.9 7581.0 7629.0 7648.0 7670.1 6585.4 6735.6 6835.7 6858.3 6876.0 6613.4 6638.9 6669.3 6781.4 6806.1 6254.2 6574.5 6716.1 6719.5 6723.4 4619.2 4667.5 4702.4 4826.5 4846.1 4764.8 4885.2 4886.8 4949.0 5036.1 04:45:41 INFO - PROCESS | 25656 | 04:45:41 INFO - PROCESS | 25656 | [#4] prototype.html Cycles:180 Average:4395.34 Median:5093.76 stddev:1289.10 (25.3%) stddev-sans-first:1255.53 04:45:41 INFO - PROCESS | 25656 | Values: 299.5 304.7 305.0 309.2 311.1 5165.9 5170.4 5178.5 5180.6 5197.6 5078.9 5086.2 5097.2 5101.0 5109.6 3813.3 3897.9 3957.4 3987.6 3990.7 3932.8 3983.1 3996.6 4002.5 4004.4 3974.8 3979.8 3986.1 3988.0 3988.7 3713.8 3938.6 3941.8 4007.4 4020.2 3408.8 3418.6 3428.7 3436.9 3437.3 4924.7 4935.3 4960.5 4961.6 4963.8 4193.0 4470.1 4485.4 4486.8 4490.4 5262.6 5283.4 5291.9 5295.5 5303.7 3731.5 3732.9 3737.5 3755.2 3756.5 5262.9 5530.3 5584.2 5600.6 5603.2 3806.6 3814.9 3818.5 3842.5 3852.3 3872.9 3878.1 3894.0 3898.6 3911.0 4470.5 4478.7 4485.9 4494.5 4498.0 5206.9 5244.3 5251.7 5284.3 5382.8 1299.9 1316.4 1319.0 1325.5 1330.9 816.0 826.9 831.0 833.5 872.5 4647.3 4650.5 4688.6 4696.2 4708.2 5425.6 5443.2 5445.4 5446.4 5449.7 4484.1 4622.3 4623.7 4636.7 4636.7 2892.5 2909.9 2910.9 2912.2 2924.4 5042.0 5044.8 5097.4 5112.8 5138.6 5338.5 5537.7 5542.9 5594.4 5638.2 5095.4 5103.3 5112.5 5116.6 5122.2 5408.2 5423.7 5450.6 5474.9 5496.6 5123.4 5213.7 5296.9 5306.9 5336.3 5092.1 5109.6 5121.5 5155.2 5180.2 3751.9 3773.1 3783.3 3783.4 3848.4 5071.7 5436.0 5439.8 5469.5 5505.4 5338.3 5386.2 5390.1 5395.1 5417.5 5165.4 5369.2 5375.9 5380.8 5454.7 5104.4 5147.9 5149.9 5155.4 5225.4 5129.5 5219.2 5382.6 5404.7 5405.8 5266.5 5281.3 5283.5 5286.0 5308.0 04:45:41 INFO - PROCESS | 25656 | 04:45:41 INFO - PROCESS | 25656 | [#5] yui.html Cycles:180 Average:16162.69 Median:531.52 stddev:22148.05 (4166.9%) stddev-sans-first:22179.63 04:45:41 INFO - PROCESS | 25656 | Values: 669.7 673.0 707.1 718.7 726.0 12618.6 13102.1 13283.1 13311.3 13322.0 13115.5 13201.7 13291.3 13369.5 13411.7 620.3 779.0 791.2 796.7 797.3 765.7 793.5 795.7 797.1 802.3 835.0 847.1 847.2 847.3 850.2 836.0 836.6 838.8 839.3 843.8 605.9 608.8 609.1 609.7 613.1 13060.8 13084.5 13086.4 13098.1 13117.1 11803.5 11954.3 12597.4 12823.2 12983.5 11793.4 12149.5 12223.9 12588.6 12619.9 4153.7 4207.3 4216.2 4225.2 4239.8 59513.7 60187.4 60625.7 60735.4 61269.1 10251.7 10276.6 10397.6 10438.7 10778.6 17002.9 17141.1 17214.2 17328.8 17950.4 6631.9 6759.0 6839.7 6868.0 6925.3 3597.5 3758.3 3768.0 3857.2 3878.9 2781.2 3334.9 3497.4 3501.7 3512.3 549.3 566.5 567.9 569.2 579.3 518.7 527.7 535.7 556.4 564.9 7383.5 7631.3 7655.2 7876.4 8284.1 512.6 530.3 532.7 561.0 561.4 3227.5 3300.7 3326.3 3418.1 3421.7 57500.0 59116.1 59585.7 59721.7 59723.0 87102.0 90447.1 91266.5 91600.0 91978.5 44821.3 45195.5 52702.7 75790.0 77502.6 6348.6 6373.0 6430.8 6436.3 6493.0 43745.8 47040.8 47044.5 48257.8 48772.5 37678.4 54450.0 65511.0 65775.0 65885.7 9296.1 9532.7 9543.8 9789.6 9859.6 11131.4 11217.8 11303.7 11332.4 11787.6 9467.5 9659.0 9687.2 9689.7 11526.2 10121.0 11465.2 11879.2 11931.5 12202.7 11185.3 11307.9 11401.7 11565.7 11617.1 9876.4 10189.6 10229.9 10267.9 10383.7 9271.4 9811.8 10069.7 10110.4 10139.8 04:45:41 INFO - PROCESS | 25656 | -------- Summary: end -------- 04:45:41 INFO - PROCESS | 25656 | 04:45:42 INFO - TEST-INFO | 25656: exit 0 04:45:42 INFO - TEST-OK | dromaeo_css | took 1116293ms 04:45:42 INFO - TEST-START | kraken 04:45:42 INFO - operating with platform_type : linux_ 04:45:42 INFO - Initialising browser for kraken test... 04:45:42 INFO - TEST-INFO | started process 25893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ0Ao_T/profile http://localhost:49557/getInfo.html) 04:45:47 INFO - PROCESS | 25893 | __metrics Screen width/height:1600/1200 04:45:47 INFO - PROCESS | 25893 | colorDepth:24 04:45:47 INFO - PROCESS | 25893 | Browser inner width/height: 1024/697 04:45:47 INFO - PROCESS | 25893 | __metrics 04:45:48 ERROR - PROCESS | 25893 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:45:49 INFO - TEST-INFO | 25893: exit 0 04:45:49 INFO - Browser initialized. 04:45:49 INFO - Running cycle 1/1 for kraken test... 04:45:49 INFO - TEST-INFO | started process 26011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ0Ao_T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:01 INFO - PROCESS | 26011 | RSS: Main: 186306560 04:46:01 INFO - PROCESS | 26011 | 04:46:03 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49557/tests/kraken/driver.html?testName=audio-beat-detection) 04:46:04 INFO - PROCESS | 26011 | RSS: Main: 190935040 04:46:04 INFO - PROCESS | 26011 | 04:46:07 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49557/tests/kraken/driver.html?testName=audio-dft) 04:46:08 INFO - PROCESS | 26011 | RSS: Main: 190599168 04:46:08 INFO - PROCESS | 26011 | 04:46:11 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49557/tests/kraken/driver.html?testName=audio-fft) 04:46:11 INFO - PROCESS | 26011 | RSS: Main: 186953728 04:46:11 INFO - PROCESS | 26011 | 04:46:13 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49557/tests/kraken/driver.html?testName=audio-oscillator) 04:46:14 INFO - PROCESS | 26011 | RSS: Main: 186933248 04:46:14 INFO - PROCESS | 26011 | 04:46:16 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49557/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:46:17 INFO - PROCESS | 26011 | RSS: Main: 187932672 04:46:17 INFO - PROCESS | 26011 | 04:46:20 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49557/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:21 INFO - PROCESS | 26011 | RSS: Main: 188026880 04:46:21 INFO - PROCESS | 26011 | 04:46:24 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49557/tests/kraken/driver.html?testName=imaging-desaturate) 04:46:25 INFO - PROCESS | 26011 | RSS: Main: 184954880 04:46:25 INFO - PROCESS | 26011 | 04:46:28 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49557/tests/kraken/driver.html?testName=json-parse-financial) 04:46:28 INFO - PROCESS | 26011 | RSS: Main: 186032128 04:46:28 INFO - PROCESS | 26011 | 04:46:30 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49557/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:46:31 INFO - PROCESS | 26011 | RSS: Main: 186712064 04:46:31 INFO - PROCESS | 26011 | 04:46:33 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49557/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:46:33 INFO - PROCESS | 26011 | RSS: Main: 187187200 04:46:33 INFO - PROCESS | 26011 | 04:46:36 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49557/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:46:36 INFO - PROCESS | 26011 | RSS: Main: 187494400 04:46:36 INFO - PROCESS | 26011 | 04:46:39 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:40 INFO - PROCESS | 26011 | RSS: Main: 187441152 04:46:40 INFO - PROCESS | 26011 | 04:46:43 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:46:43 INFO - PROCESS | 26011 | RSS: Main: 187277312 04:46:43 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | Cycle 1(1): loaded http://localhost:49557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49557/tests/kraken/driver.html?testName=ai-astar) 04:46:45 INFO - PROCESS | 26011 | RSS: Main: 188764160 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | __start_tp_report 04:46:45 INFO - PROCESS | 26011 | _x_x_mozilla_page_load 04:46:45 INFO - PROCESS | 26011 | _x_x_mozilla_page_load_details 04:46:45 INFO - PROCESS | 26011 | |i|pagename|runs| 04:46:45 INFO - PROCESS | 26011 | |0;ai-astar;116;110;114;113;114;114;114;112;113;114 04:46:45 INFO - PROCESS | 26011 | |1;audio-beat-detection;164;132;168;184;136;161;160;134;201;139 04:46:45 INFO - PROCESS | 26011 | |2;audio-dft;166;166;169;166;162;163;165;162;163;163 04:46:45 INFO - PROCESS | 26011 | |3;audio-fft;77;78;77;164;77;78;77;76;179;77 04:46:45 INFO - PROCESS | 26011 | |4;audio-oscillator;86;87;140;86;86;87;127;91;87;146 04:46:45 INFO - PROCESS | 26011 | |5;imaging-gaussian-blur;117;118;118;118;121;120;117;119;119;119 04:46:45 INFO - PROCESS | 26011 | |6;imaging-darkroom;148;149;149;148;148;147;147;147;147;147 04:46:45 INFO - PROCESS | 26011 | |7;imaging-desaturate;95;95;96;96;96;95;96;96;95;95 04:46:45 INFO - PROCESS | 26011 | |8;json-parse-financial;66;67;66;66;65;67;67;66;66;65 04:46:45 INFO - PROCESS | 26011 | |9;json-stringify-tinderbox;67;67;66;68;67;66;66;67;67;65 04:46:45 INFO - PROCESS | 26011 | |10;stanford-crypto-aes;84;83;83;84;95;85;85;91;114;86 04:46:45 INFO - PROCESS | 26011 | |11;stanford-crypto-ccm;134;137;134;157;129;138;141;142;139;135 04:46:45 INFO - PROCESS | 26011 | |12;stanford-crypto-pbkdf2;173;170;168;168;171;168;173;173;171;167 04:46:45 INFO - PROCESS | 26011 | |13;stanford-crypto-sha256-iterative;69;68;68;74;74;68;69;66;72;67 04:46:45 INFO - PROCESS | 26011 | __end_tp_report 04:46:45 INFO - PROCESS | 26011 | __start_cc_report 04:46:45 INFO - PROCESS | 26011 | _x_x_mozilla_cycle_collect,969 04:46:45 INFO - PROCESS | 26011 | __end_cc_report 04:46:45 INFO - PROCESS | 26011 | __startTimestamp1465904805793__endTimestamp 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | ------- Summary: start ------- 04:46:45 INFO - PROCESS | 26011 | Number of tests: 14 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:1.58 (1.4%) stddev-sans-first:1.36 04:46:45 INFO - PROCESS | 26011 | Values: 116.0 110.0 114.0 113.0 114.0 114.0 114.0 112.0 113.0 114.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#1] audio-beat-detection Cycles:10 Average:157.90 Median:162.50 stddev:23.02 (14.2%) stddev-sans-first:24.31 04:46:45 INFO - PROCESS | 26011 | Values: 164.0 132.0 168.0 184.0 136.0 161.0 160.0 134.0 201.0 139.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.50 stddev:2.27 (1.4%) stddev-sans-first:2.35 04:46:45 INFO - PROCESS | 26011 | Values: 166.0 166.0 169.0 166.0 162.0 163.0 165.0 162.0 163.0 163.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#3] audio-fft Cycles:10 Average:96.00 Median:77.00 stddev:39.95 (51.9%) stddev-sans-first:41.78 04:46:45 INFO - PROCESS | 26011 | Values: 77.0 78.0 77.0 164.0 77.0 78.0 77.0 76.0 179.0 77.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:86.50 stddev:24.87 (28.8%) stddev-sans-first:25.67 04:46:45 INFO - PROCESS | 26011 | Values: 86.0 87.0 140.0 86.0 86.0 87.0 127.0 91.0 87.0 146.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:1.26 (1.1%) stddev-sans-first:1.20 04:46:45 INFO - PROCESS | 26011 | Values: 117.0 118.0 118.0 118.0 121.0 120.0 117.0 119.0 119.0 119.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:46:45 INFO - PROCESS | 26011 | Values: 148.0 149.0 149.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:46:45 INFO - PROCESS | 26011 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 04:46:45 INFO - PROCESS | 26011 | Values: 66.0 67.0 66.0 66.0 65.0 67.0 67.0 66.0 66.0 65.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 04:46:45 INFO - PROCESS | 26011 | Values: 67.0 67.0 66.0 68.0 67.0 66.0 66.0 67.0 67.0 65.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:85.00 stddev:9.59 (11.3%) stddev-sans-first:10.00 04:46:45 INFO - PROCESS | 26011 | Values: 84.0 83.0 83.0 84.0 95.0 85.0 85.0 91.0 114.0 86.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:138.50 stddev:7.50 (5.4%) stddev-sans-first:7.77 04:46:45 INFO - PROCESS | 26011 | Values: 134.0 137.0 134.0 157.0 129.0 138.0 141.0 142.0 139.0 135.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:171.00 stddev:2.35 (1.4%) stddev-sans-first:2.26 04:46:45 INFO - PROCESS | 26011 | Values: 173.0 170.0 168.0 168.0 171.0 168.0 173.0 173.0 171.0 167.0 04:46:45 INFO - PROCESS | 26011 | 04:46:45 INFO - PROCESS | 26011 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:2.84 (4.1%) stddev-sans-first:3.00 04:46:45 INFO - PROCESS | 26011 | Values: 69.0 68.0 68.0 74.0 74.0 68.0 69.0 66.0 72.0 67.0 04:46:45 INFO - PROCESS | 26011 | -------- Summary: end -------- 04:46:45 INFO - PROCESS | 26011 | 04:46:46 INFO - TEST-INFO | 26011: exit 0 04:46:46 INFO - TEST-OK | kraken | took 64451ms 04:46:46 INFO - SUITE-END | took 1180s 04:46:46 INFO - Completed test suite (00:19:40) 04:46:46 INFO - javascript benchmark 04:46:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6326.58961844075, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.554505734025, 2677.8928842846285, 2682.10149599884, 2685.140754958414, 2697.7437143471375, 4705.976470117645, 4767.308740232668, 4805.3993250843605, 4848.806047758094, 4873.317735517022, 4636.350910872472, 4821.951780482194, 4833.154198015351, 4877.951220487794, 4923.040007198598, 4426.690131690775, 4446.1107778444275, 4541.137183935041, 4542.977829988259, 4569.702969306984, 548.9616683888702, 4309.987153019038, 4405.140997505488, 4416.624586910117, 4426.424564806571, 4425.867223983286, 4435.977820110895, 4446.466424029105, 4449.0879369729455, 4517.141743068806, 4460.085682435093, 4471.776411179428, 4478.216312145361, 4479.17135329965, 4533.84131555394, 4291.249031419489, 4414.624756895668, 4428.822847086113, 4454.465464144291, 4462.062966776981, 4765.833195838164, 4804.111239420718, 4848.054629347279, 4848.345473361086, 4909.631777616693, 4941.332920055783, 5179.145441002268, 5184.300119483859, 5199.558037566811, 5256.080185967478, 5082.720450375228, 5114.590832733373, 5123.359580052494, 5148.56237219833, 5152.201408781645, 4809.807607695688, 4816.084943860656, 4817.0365926814775, 4829.1307564638, 4866.0024694938165, 5234.633575649744, 5253.212018197224, 5261.868453288698, 5286.101362768339, 5320.973395133077, 5123.97438012815, 5127.0, 5128.564072053842, 5137.974310128426, 5201.531862132426, 5190.792368305301, 5218.0, 5218.556422704112, 5230.921536176884, 5296.708681022581, 4921.606271498272, 5110.310108135429, 5140.922886156711, 5161.458046905096, 5174.249733788655, 5141.331626888556, 5148.3564554430695, 5152.819651312261, 5182.32629758129, 5186.974065129726, 4358.564143585616, 4358.825646974085, 4363.4763828340165, 4379.781010949439, 4416.933745993812, 3736.3648179809497, 3762.6801721853403, 3808.8857334280015, 3823.6749876260274, 3827.9808600956817, 4289.678274129453, 4455.888602784957, 4476.037651904856, 4502.527234640315, 4544.0457503924545, 5237.162054071407, 5247.02929957959, 5252.185911183773, 5263.815766448156, 5317.069512835238, 4305.956940430556, 4357.891052723708, 4437.112577484516, 4489.349044388546, 4541.613962813198, 4636.605888499448, 4643.8374656886845, 4665.6734028617675, 4677.298405239241, 4679.742614156254, 4770.141374552614, 4844.370231869834, 4851.733154676456, 4855.830045948375, 4930.186519224288, 5004.649674522749, 5063.392392912727, 5063.468335824833, 5114.130597798308, 5206.401263854554, 4795.944892123727, 4798.856034318976, 4876.829310974099, 4882.0, 4940.6788558743565, 5135.127028405105, 5135.717535535581, 5144.202648589475, 5154.122752634842, 5169.7673604687125, 5255.947440525699, 5258.053550360972, 5260.631755777059, 5263.921041184309, 5315.415304316445, 4898.657094003385, 4986.975065124651, 5047.217681259411, 5068.163752980864, 5071.644984851025, 5024.497550244946, 5046.747662616781, 5076.974615126901, 5091.516305950929, 5138.409082955508, 4750.239961606127, 4902.264660300983, 4914.533119353656, 4943.110240156662, 4944.505549445027, 5055.292259083658, 5082.2122571001555, 5112.36095488064, 5137.152369858932, 5145.0, 4973.154563724248, 4977.104121258063, 4982.701037937735, 5019.372578427697, 5033.320501732219], "value": 4716.606374661372, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.8884911866745, 588.7115313496386, 606.5966132521874, 628.9182406287182, 645.5932762359713, 32226.35547289056, 32944.505832412506, 35297.29405411893, 35635.10912227189, 35676.2864742705, 36193.63806361942, 36916.07709807249, 36968.81515592425, 36972.63027369726, 37041.259174816485, 7560.508566943145, 7719.884201736979, 7737.690492380298, 7745.109312429058, 7775.377969762434, 7633.313001829834, 7673.3861291096855, 7680.923190768077, 7686.116096648873, 7698.384129269645, 7694.0, 7731.0336207974005, 7736.381089512825, 7754.1470438251745, 7756.069271687377, 7675.769726908202, 7701.22987701231, 7734.961325193338, 7757.728479503218, 7760.0, 7551.697932082765, 7661.195574464712, 7665.8850117248285, 7682.539047657158, 7684.193159718261, 24785.87607061953, 24892.875535622206, 24912.37719057038, 24935.0, 25117.0, 2388.1402695029774, 2796.3987742635227, 3133.9529907051415, 3290.6215785184772, 3738.327101121797, 27562.44875102507, 27856.0, 27877.606119694137, 28159.15522534327, 28733.856330718423, 3335.7831740937004, 3356.647552007053, 3419.384510788057, 3445.0526105320987, 3492.0746002309406, 220912.0, 221579.0, 222439.99999999837, 222491.0, 223465.0, 30938.215560599205, 31101.0, 31420.84289578583, 32006.35987280288, 32268.677313226566, 33642.32715345679, 33671.15822104467, 33702.65189392397, 33806.66193338084, 33876.49185262174, 12927.806082908764, 12943.482260709654, 12998.090133690741, 13104.2137471752, 13116.278604676834, 9447.0, 9560.378575392577, 9599.760005999906, 9603.711888643353, 9612.134907858326, 7755.573443460664, 7806.102298235775, 7839.0, 7849.254320839511, 7914.24814642608, 3071.1400807773857, 3103.34829685764, 3120.2511397264493, 3125.6249250090136, 3151.842407879597, 846.348311799923, 896.2231307132965, 899.7255836969787, 950.1306304731231, 989.5200827598753, 27044.864775675996, 27880.16359509218, 28030.579541306488, 28111.57832632512, 28439.146825595264, 924.5562130177552, 972.2756546372998, 997.6558087459815, 1014.102519270451, 1053.8261186904074, 14542.927285363718, 14674.633134171518, 14878.553643390716, 14891.0, 15162.166080865438, 395688.0, 397320.0, 402848.0, 403312.0, 403411.0, 33137.66862331394, 33208.3358332832, 33250.0, 33305.50041749376, 33368.833155834065, 1174.5536696055615, 1182.6097387861985, 1203.778165162361, 1219.4939100273286, 1229.2624425344723, 26321.0, 27748.722512774613, 28028.29929251785, 28051.579226311213, 28058.43883122285, 41837.58162418459, 41943.7902810484, 42333.5766642342, 42394.78802605967, 42409.78795106005, 332471.0, 332885.0, 333158.0, 334924.0, 335767.0, 24923.376915577257, 25274.0, 25293.62059569145, 25368.746312537376, 25415.0, 39119.60880391159, 40411.1917761649, 41282.38076428916, 41492.170156597305, 42337.364939526546, 35460.82269588635, 35799.64200357963, 35967.0, 36402.63597364099, 36435.45346819747, 34458.655413445544, 35759.46360804538, 35927.0, 35985.640143599274, 36020.45969310515, 33534.32931341311, 34966.30067398689, 35069.47395789014, 35129.473057904666, 35316.823415882754, 31043.068707938797, 32296.674480512374, 32471.0, 32543.34913301768, 32751.18122046968, 25383.238502844943, 25430.618540721534, 25461.618075728507, 25769.742302576735, 25919.35201619899], "value": 15641.098022215368, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.81941438987695, 369.2135750850688, 372.6068997207948, 381.8701641441911, 382.74164938666394, 15736.527904162878, 17280.48158555244, 18159.364422245224, 18238.361657341997, 18241.817581824176, 11800.232984855978, 15693.21533923305, 16596.66806663866, 16597.41909033184, 17385.565360865985, 4579.725216487013, 4728.078024785168, 4755.144074066667, 4759.595434388081, 4761.523847615245, 3484.6689564491335, 4649.93025104622, 5112.105381558231, 5388.218708287296, 5391.353037635489, 5452.863678408052, 5463.726813659321, 5487.122060470326, 5504.4495550445035, 5524.944750552483, 5346.224797404393, 5386.596005299599, 5391.056565101092, 5416.756245968922, 5482.506574408322, 5214.921776173361, 5269.894602107975, 5272.894542109137, 5279.70961597112, 5289.894202115975, 11720.765584688344, 12472.875271247261, 12531.624051278477, 12542.81185782214, 12589.30758808265, 1807.2499912536282, 1946.6106778644328, 2061.5258490547108, 2331.80179684727, 2379.3337865397716, 9268.16586507211, 9417.152456278967, 9732.318737688365, 12587.74824503514, 13036.41336139876, 1695.4913525942168, 1732.9759569551088, 1749.7812773403325, 1815.6550255451555, 1868.962620747591, 58347.70826145884, 62234.0, 70122.64938675275, 71077.64461177713, 71266.64366678185, 8801.0, 9781.853272200922, 9850.80298394028, 9908.315586350338, 10077.344972576759, 13210.0, 13265.336733163304, 13304.201747895157, 13311.267880266485, 13368.598942031755, 6720.6639668016405, 7066.328698773608, 7145.249748776304, 7188.964055179691, 7249.130104387507, 6613.0, 6632.568883022588, 6677.23211830636, 6680.0981867448245, 6692.431143352772, 4104.302268614343, 4147.19129769692, 4382.342648602735, 4460.843870464518, 4487.775611219426, 1651.2981982657564, 1718.2611477064731, 1798.8740788144705, 1824.087956021989, 1853.7312089747181, 785.4619585583779, 839.8782176584361, 891.416122439803, 913.0777914306598, 960.5341409416427, 15690.686186276438, 16644.750328745078, 16737.808821627234, 17153.485395438158, 17221.655566888592, 834.1732995029713, 835.6782638684028, 846.593635055177, 864.9956750216209, 879.1647934462286, 9490.145886870216, 9674.322797404255, 9743.561539730728, 9813.411195328303, 9889.307748457539, 409566.0, 412743.0, 421179.0, 425450.0, 425984.0, 76462.0, 80529.59735201286, 80626.0, 82342.58828705818, 83246.58376708078, 858.2704701004221, 881.8089907035263, 894.0344428017726, 898.3352319283814, 898.9730308090768, 15448.227588620748, 15513.0, 15549.378024878879, 15563.144027078166, 15672.373105075669, 36429.81785091058, 36847.0, 37827.62172378241, 38123.0, 38801.6119838798, 53190.46809531855, 53608.0, 53728.194077089654, 53823.73088134534, 54271.0, 7495.88756168647, 7511.699532018658, 7584.886226706714, 7616.3906887449975, 7654.961725191339, 10759.46202689878, 10788.298760580537, 11049.613263535737, 11172.547568816002, 11222.382768947786, 9701.369410988264, 10121.190304775453, 10264.64073757415, 10283.177345812466, 10313.587456501657, 10040.949795251268, 10048.748781280527, 10056.094951454405, 10228.48857557134, 10280.383177009404, 9678.516074196403, 9819.263555233529, 10278.743031424274, 10510.31682940637, 10606.257561970588, 7288.2648863981885, 7390.6674199660065, 7544.0, 7641.159472458136, 7682.692692292246, 7578.658960346908, 8986.550672466481, 9642.807143856944, 10210.948945255226, 10243.692689219335], "value": 8041.694276272844, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.71089071295, 1409.6475881029742, 1494.0, 1668.8915220510657, 1669.5492217101382, 7080.468964827633, 7641.465097443182, 7819.530828150315, 8123.431359804808, 8126.146754590772, 7891.723789667363, 8097.2712455878955, 8164.1835816418325, 8168.101508834024, 8171.019477662674, 2248.325502349293, 2260.7739226077424, 2280.9201677941273, 2281.4068342231058, 2286.2912497125863, 2240.932772016842, 2242.517858660388, 2250.7524172341027, 2269.273832373641, 2278.134308962592, 2230.6765518999737, 2232.7767223277706, 2244.708187935574, 2250.763669814662, 2282.018731945263, 2200.141944641591, 2202.2292197730826, 2209.834262430316, 2223.4219103033165, 2226.543558570489, 2109.040386624082, 2123.341764053133, 2126.1176611706123, 2159.427751645815, 2165.7076294700173, 8155.143709910492, 8186.918130818675, 8202.138775428613, 8214.1375155609, 8290.253877151084, 4707.952920470786, 4814.9518504815205, 4826.903461930741, 4833.250846118857, 4852.975735121302, 3006.8573941902155, 3070.3398769264713, 3089.3203495231014, 3116.439040972624, 3167.509036099408, 952.7951490429522, 986.6349450703286, 997.7206382212992, 1001.5993602558962, 1002.5488530161457, 11080.168987325982, 11171.608993685264, 11173.0, 11178.0, 11187.0, 4306.160298741778, 4316.611504964505, 4417.315316126005, 4487.259602165672, 4489.820407183676, 9357.532123393803, 9376.718698439057, 9396.906030939603, 9399.389039712396, 9416.340856140005, 4725.102230576248, 4753.572178503882, 4755.0, 4759.38128043359, 4773.212419950739, 3782.111203867089, 4200.390943313202, 4236.068065025689, 4324.56754324565, 4364.236258654722, 3726.8509259629855, 3751.8369305515375, 3825.12022234882, 3833.4824798651825, 3969.900752481153, 1183.3432444993111, 1231.58741821489, 1231.6736064942797, 1238.0590751029283, 1259.3640211693219, 788.9013873265842, 792.7899106736719, 809.9228026724443, 821.2977903892087, 847.51268020887, 5310.654807437504, 5335.039692855245, 5411.647088227943, 5449.482299181572, 5456.59075569326, 891.2290868398918, 894.8165626046645, 912.2884150362728, 929.2333824594737, 930.06993006993, 3533.0990597398013, 3690.55713314404, 3728.067983004249, 3742.7941463219786, 3763.040424691741, 9720.125188733047, 9977.301588888853, 9994.050565196294, 10117.038881306264, 10124.746881328027, 9971.252156088321, 10058.094771470604, 10058.597656093674, 10074.244431667654, 10092.0, 7576.81057973544, 7637.4653774236385, 7638.961805190938, 7712.074551053909, 7760.805979850436, 5459.399466058651, 5461.672299662033, 5466.180072988925, 5529.889402211853, 5563.944360556343, 9237.630494780133, 9243.260539156718, 9289.814203716023, 9383.624655013722, 9474.0, 9360.4383736976, 9424.434533927986, 9458.29062820305, 9495.0, 9511.334206605472, 5922.822315330547, 6275.937240627535, 6374.553781235269, 6442.452391546583, 6488.091667166695, 7527.924720752722, 7580.9620951894885, 7628.961855190689, 7648.0, 7670.117936437381, 6585.440237579859, 6735.6295403753265, 6835.658217089026, 6858.279880612663, 6876.002979568035, 6613.43785778195, 6638.933610664025, 6669.266380698023, 6781.3896749290825, 6806.081179040766, 6254.249490061222, 6574.474042076718, 6716.059751634677, 6719.496037797087, 6723.394894459522, 4619.168549660959, 4667.509911459248, 4702.412198475191, 4826.541478559531, 4846.103470857903, 4764.78558464863, 4885.2427873679635, 4886.780094895809, 4948.950510494849, 5036.143855544639], "value": 4270.315851348206, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.50731047426984, 304.7257468278549, 305.0452084974031, 309.23927139237475, 311.12728795727975, 5165.870853228671, 5170.379554453466, 5178.508041736034, 5180.627133809544, 5197.584193264539, 5078.949210507893, 5086.160783470723, 5097.209932460474, 5101.0, 5109.565686916617, 3813.3326667833157, 3897.883063508085, 3957.3866050762176, 3987.6411122998925, 3990.720649554518, 3932.803359832011, 3983.1237127831973, 3996.582067848953, 4002.4790579579717, 4004.3793212052033, 3974.761514309136, 3979.8408063677416, 3986.1429792594586, 3987.9800600996955, 3988.720789544733, 3713.7771733696063, 3938.5864484229314, 3941.783201923893, 4007.3788562772816, 4020.1758639478985, 3408.8466019028956, 3418.5555877735737, 3428.708559772422, 3436.914077148066, 3437.2781715839706, 4924.719572911069, 4935.3090567320605, 4960.479149689267, 4961.603071754251, 4963.751812409365, 4192.958070419288, 4470.061287129706, 4485.407680273489, 4486.842960496399, 4490.39379683745, 5262.60530460217, 5283.392409872876, 5291.894162116774, 5295.523402893758, 5303.655262407931, 3731.477593136963, 3732.869349572752, 3737.4767532545466, 3755.1926335837925, 3756.455313979485, 5262.8684282892855, 5530.2810634617645, 5584.21820945068, 5600.5519558435635, 5603.215549823028, 3806.600306967784, 3814.885553433346, 3818.537043606858, 3842.481265029241, 3852.287326844543, 3872.9031774205305, 3878.1080351518744, 3893.96106038936, 3898.590647981978, 3910.9804450977563, 4470.463544374696, 4478.678789757029, 4485.887852803706, 4494.483134439516, 4497.955020449819, 5206.869828254324, 5244.29202057725, 5251.684898906078, 5284.339457567804, 5382.838514844561, 1299.8960083193322, 1316.414195682912, 1319.0, 1325.4896864706964, 1330.9068365214341, 815.9840997957581, 826.9049059358131, 830.9916900830914, 833.470746076246, 872.4808738800403, 4647.34937108805, 4650.511696271843, 4688.624910007191, 4696.1546921554445, 4708.199606066908, 5425.620206585501, 5443.237946687467, 5445.413428621452, 5446.400895901447, 5449.719315960746, 4484.1255955088445, 4622.2604383299185, 4623.653226007996, 4636.698614590041, 4636.744979026119, 2892.5082735934943, 2909.854507274628, 2910.8544572771702, 2912.2137023004093, 2924.400497897926, 5042.042012017705, 5044.8234311798915, 5097.362829646294, 5112.769925353368, 5138.588912887035, 5338.54622357104, 5537.667739935617, 5542.861428464321, 5594.384617692051, 5638.238837756932, 5095.439501654815, 5103.311053007871, 5112.463191364853, 5116.641835071509, 5122.231665250242, 5408.215808707637, 5423.674579525241, 5450.563954883679, 5474.945250547444, 5496.642718223303, 5123.359580052494, 5213.687178769286, 5296.920546191887, 5306.867328316823, 5336.306280183551, 5092.090466075222, 5109.565686916654, 5121.539061484485, 5155.200943853709, 5180.197069454241, 3751.868684596026, 3773.1321795987624, 3783.281176576442, 3783.432485127253, 3848.4034974578985, 5071.670341427943, 5435.967166238402, 5439.836804895859, 5469.511372325662, 5505.449455054462, 5338.3060202173465, 5386.218998245311, 5390.137577987503, 5395.136778115482, 5417.458254174709, 5165.380154381498, 5369.248305237348, 5375.919361209663, 5380.811671591476, 5454.727263636723, 5104.41299250591, 5147.94467134244, 5149.948500514947, 5155.43290238081, 5225.425203227566, 5129.461406552258, 5219.217117432416, 5382.623216374816, 5404.7297635118875, 5405.756740946588, 5266.526012658879, 5281.287026251407, 5283.524482796567, 5285.973570132125, 5307.982966472716], "value": 3977.617439401876, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.748844183431, 672.9663516824161, 707.1302298173249, 718.6550455781224, 725.9782206533806, 12618.621441356763, 13102.148360356594, 13283.136596121258, 13311.334433278322, 13322.0, 13115.54095606654, 13201.735965280688, 13291.335433228323, 13369.465221391132, 13411.664708382272, 620.2587907450599, 778.9844203115935, 791.1811275330034, 796.6932730898587, 797.3023604346197, 765.6554550452319, 793.4604468961104, 795.741384050186, 797.1231645190273, 802.3300544045729, 835.0230230630177, 847.1232274595794, 847.1782371100023, 847.3390755210945, 850.2050582705191, 836.0093289451988, 836.6277006731976, 838.7986883148061, 839.3159574946399, 843.7510934274404, 605.9272887253513, 608.8417011576978, 609.1015751766109, 609.6738245038883, 613.089562000429, 13060.804087938688, 13084.476620935151, 13086.41111149991, 13098.148620339647, 13117.081804273705, 11803.468843902045, 11954.282743035446, 12597.433115509824, 12823.230606163661, 12983.480660773557, 11793.351365674884, 12149.514019439212, 12223.877761222362, 12588.559400421032, 12619.864212220853, 4153.68847336451, 4207.284761590537, 4216.198922204771, 4225.218334608107, 4239.830406783725, 59513.70243148757, 60187.398126019056, 60625.6968715158, 60735.39264607386, 61269.08096378558, 10251.743706407251, 10276.588936442458, 10397.636082737068, 10438.68683939483, 10778.622748203776, 17002.914985424995, 17141.142942852806, 17214.225359858836, 17328.82671173272, 17950.371736989142, 6631.933680663228, 6758.966205168943, 6839.726410943606, 6868.038474613558, 6925.272846351161, 3597.4783656370205, 3758.342290099222, 3768.0, 3857.187122052631, 3878.864239751595, 2781.1656503049003, 3334.949975750317, 3497.370473314828, 3501.719862411001, 3512.2799826035603, 549.3243310727827, 566.4562020460322, 567.8807450435372, 569.2031156381017, 579.3048341989629, 518.6602775182262, 527.6781163490268, 535.6652092442224, 556.4102051825079, 564.9491545760901, 7383.520071195355, 7631.275028872248, 7655.2344765523, 7876.448648594658, 8284.08875023747, 512.5617596954625, 530.3389428774603, 532.7043490862609, 561.0294191049426, 561.4469747298907, 3227.5158726191257, 3300.669933006728, 3326.3181047885128, 3418.111291064341, 3421.709154721827, 57500.0, 59116.11325830116, 59585.702071489366, 59721.70139149277, 59723.0, 87102.0, 90447.09552904518, 91266.54366728256, 91600.0, 91978.54010729904, 44821.327680084825, 45195.54804451979, 52702.73648631809, 75789.96840126334, 77502.61248693608, 6348.619082855043, 6372.968135159294, 6430.807075787734, 6436.324185960594, 6493.0, 43745.78127109344, 47040.7647961758, 47044.529554704015, 48257.75871120622, 48772.512274878216, 37678.434823477124, 54450.0, 65511.0, 65775.0, 65885.67057164683, 9296.07039296065, 9532.714018579454, 9543.761405964906, 9789.559469823733, 9859.556319965475, 11131.443427828413, 11217.775644487228, 11303.717407064889, 11332.37671928019, 11787.646370608896, 9467.479288639192, 9658.951705241428, 9687.176589989647, 9689.70930872075, 11526.15581506955, 10121.0, 11465.197436179387, 11879.168458207843, 11931.522739090338, 12202.694932626755, 11185.272957257752, 11307.886921131012, 11401.657950261506, 11565.7108572283, 11617.128715346214, 9876.40741555509, 10189.643362482277, 10229.897701023192, 10267.897321026694, 10383.68848934503, 9271.397359171633, 9811.754706132118, 10069.69790906274, 10110.39337639744, 10139.797204056025], "value": 6362.817178570128, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 114.0, 113.0, 114.0, 114.0, 114.0, 112.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 168.0, 184.0, 136.0, 161.0, 160.0, 134.0, 201.0, 139.0], "value": 157.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 169.0, 166.0, 162.0, 163.0, 165.0, 162.0, 163.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 164.0, 77.0, 78.0, 77.0, 76.0, 179.0, 77.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 140.0, 86.0, 86.0, 87.0, 127.0, 91.0, 87.0, 146.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 121.0, 120.0, 117.0, 119.0, 119.0, 119.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 65.0, 67.0, 67.0, 66.0, 66.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 66.0, 67.0, 67.0, 65.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 84.0, 95.0, 85.0, 85.0, 91.0, 114.0, 86.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 137.0, 134.0, 157.0, 129.0, 138.0, 141.0, 142.0, 139.0, 135.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 168.0, 168.0, 171.0, 168.0, 173.0, 173.0, 171.0, 167.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 74.0, 74.0, 68.0, 69.0, 66.0, 72.0, 67.0], "value": 69.5, "unit": "score"}]}]} 04:46:47 INFO - Return code: 0 04:46:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:46:47 ERROR - # TBPL SUCCESS # 04:46:47 INFO - Running post-action listener: _resource_record_post_action 04:46:47 INFO - ##### 04:46:47 INFO - ##### Finished run-tests step (success) 04:46:47 INFO - ##### 04:46:47 INFO - Running post-run listener: _resource_record_post_run 04:46:47 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543244288; Read time: 20; Write time: 386792 04:46:47 INFO - TinderboxPrint: CPU usage
13.4% 04:46:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:46:47 INFO - TinderboxPrint: I/O write bytes / time
543,244,288 / 386,792 04:46:47 INFO - TinderboxPrint: CPU idle
8,271.2 (86.6%) 04:46:47 INFO - TinderboxPrint: CPU user
1,230.4 (12.9%) 04:46:47 INFO - TinderboxPrint: Swap in / out
0 / 0 04:46:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245219328; Read time: 0; Write time: 249172 04:46:47 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298024960; Read time: 20; Write time: 137620 04:46:47 INFO - Running post-run listener: _upload_blobber_files 04:46:47 INFO - Blob upload gear active. 04:46:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:46:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:46:47 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'] 04:46:47 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 04:46:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:46:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:46:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:46:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:48 INFO - (blobuploader) - INFO - Done attempting. 04:46:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:46:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:46:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:53 INFO - (blobuploader) - INFO - Done attempting. 04:46:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:46:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:46:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:54 INFO - (blobuploader) - INFO - Done attempting. 04:46:54 INFO - (blobuploader) - INFO - Iteration through files over. 04:46:54 INFO - Return code: 0 04:46:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:46:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:46:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d22965f76299056a865ddcf7a83570c362f90d91d1e15e07ad28145a31df9a98c10b66f358507381c2f6b57157c8a5f2a2bb655ab7333228c165df7cc14ad9b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83275f179395541c22e22a042594969899725446db5c03671a3f2b88d81d47f0dc7391f658d2b10dc154703335e35ef7b3547b55969a4beae642e341735c7764", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75421c08242819d65370a7e96da8bffa8cb3d8c75dfc36f6ed5365a1e96251cf9622b4e07dc6067c24e42f0bd5355c16a86a136894681c8abe5749d35f2504b6"} 04:46:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:46:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:46:54 INFO - Contents: 04:46:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d22965f76299056a865ddcf7a83570c362f90d91d1e15e07ad28145a31df9a98c10b66f358507381c2f6b57157c8a5f2a2bb655ab7333228c165df7cc14ad9b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83275f179395541c22e22a042594969899725446db5c03671a3f2b88d81d47f0dc7391f658d2b10dc154703335e35ef7b3547b55969a4beae642e341735c7764", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75421c08242819d65370a7e96da8bffa8cb3d8c75dfc36f6ed5365a1e96251cf9622b4e07dc6067c24e42f0bd5355c16a86a136894681c8abe5749d35f2504b6"} 04:46:54 INFO - Running post-run listener: copy_logs_to_upload_dir 04:46:54 INFO - Copying logs to upload dir... 04:46:54 INFO - mkdir: /builds/slave/test/build/upload/logs 04:46:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.685514 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-14 04:46:53.081276) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 04:46:53.087042) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154 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/d22965f76299056a865ddcf7a83570c362f90d91d1e15e07ad28145a31df9a98c10b66f358507381c2f6b57157c8a5f2a2bb655ab7333228c165df7cc14ad9b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83275f179395541c22e22a042594969899725446db5c03671a3f2b88d81d47f0dc7391f658d2b10dc154703335e35ef7b3547b55969a4beae642e341735c7764", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75421c08242819d65370a7e96da8bffa8cb3d8c75dfc36f6ed5365a1e96251cf9622b4e07dc6067c24e42f0bd5355c16a86a136894681c8abe5749d35f2504b6"} build_url:https://queue.taskcluster.net/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011508 build_url: 'https://queue.taskcluster.net/v1/task/A_JQDLXWQkeIWaTp2Mzw2Q/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/d22965f76299056a865ddcf7a83570c362f90d91d1e15e07ad28145a31df9a98c10b66f358507381c2f6b57157c8a5f2a2bb655ab7333228c165df7cc14ad9b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83275f179395541c22e22a042594969899725446db5c03671a3f2b88d81d47f0dc7391f658d2b10dc154703335e35ef7b3547b55969a4beae642e341735c7764", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75421c08242819d65370a7e96da8bffa8cb3d8c75dfc36f6ed5365a1e96251cf9622b4e07dc6067c24e42f0bd5355c16a86a136894681c8abe5749d35f2504b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 04:46:53.113905) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:46:53.114315) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465903572.123272-1652419154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:46:53.196811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 04:46:53.197163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 04:46:53.197540) ========= ========= Total master_lag: 0.17 =========