builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1465269759.04 results: success (0) buildid: 20160606173007 builduid: 9dd58ac981624fbb9c586a606df56dfe revision: d9f0b4e9a8add9e0931e1c549ccba22f7dbc67d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:39.044389) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:39.045420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:39.045852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:39.110914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:39.111334) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 20:22:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-06-06 20:22:39 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086372 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:39.212532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:39.212906) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015122 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:39.262558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 20:22:39.263002) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d9f0b4e9a8add9e0931e1c549ccba22f7dbc67d3 --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 d9f0b4e9a8add9e0931e1c549ccba22f7dbc67d3 --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=03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 20:22:39,468 truncating revision to first 12 chars 2016-06-06 20:22:39,468 Setting DEBUG logging. 2016-06-06 20:22:39,468 attempt 1/10 2016-06-06 20:22:39,468 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d9f0b4e9a8ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 20:22:40,530 unpacking tar archive at: fx-team-d9f0b4e9a8ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.449647 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 20:22:40.726198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:40.726538) ========= script_repo_revision: d9f0b4e9a8add9e0931e1c549ccba22f7dbc67d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:40.727000) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:40.727301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 20:22:40.737618) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-06 20:22:40.737928) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:22:41 INFO - MultiFileLogger online at 20160606 20:22:41 in /builds/slave/test 20:22:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:22:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:22:41 INFO - {'append_to_log': False, 20:22:41 INFO - 'base_work_dir': '/builds/slave/test', 20:22:41 INFO - 'blob_upload_branch': 'Fx-Team', 20:22:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:22:41 INFO - 'branch': 'Fx-Team', 20:22:41 INFO - 'buildbot_json_path': 'buildprops.json', 20:22:41 INFO - 'config_files': ('talos/linux_config.py',), 20:22:41 INFO - 'default_actions': ('clobber', 20:22:41 INFO - 'read-buildbot-config', 20:22:41 INFO - 'download-and-extract', 20:22:41 INFO - 'populate-webroot', 20:22:41 INFO - 'create-virtualenv', 20:22:41 INFO - 'install', 20:22:41 INFO - 'run-tests'), 20:22:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:22:41 INFO - 'download_minidump_stackwalk': True, 20:22:41 INFO - 'download_symbols': 'ondemand', 20:22:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:22:41 INFO - 'tooltool.py': '/tools/tooltool.py', 20:22:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:22:41 INFO - '/tools/misc-python/virtualenv.py')}, 20:22:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:22:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:22:41 INFO - 'installer_path': 'installer.exe', 20:22:41 INFO - 'log_level': 'info', 20:22:41 INFO - 'log_name': 'talos', 20:22:41 INFO - 'log_to_console': True, 20:22:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:22:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:22:41 INFO - 'opt_config_files': (), 20:22:41 INFO - 'pip_index': False, 20:22:41 INFO - 'sps_profile': False, 20:22:41 INFO - 'sps_profile_interval': 0, 20:22:41 INFO - 'suite': 'dromaeojs-e10s', 20:22:41 INFO - 'system_bits': '32', 20:22:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:22:41 INFO - 'title': 'talos-linux64-ix-047', 20:22:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:22:41 INFO - 'use_talos_json': True, 20:22:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:22:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:22:41 INFO - 'work_dir': 'build'} 20:22:41 INFO - ##### 20:22:41 INFO - ##### Running clobber step. 20:22:41 INFO - ##### 20:22:41 INFO - Running pre-action listener: _resource_record_pre_action 20:22:41 INFO - Running main action method: clobber 20:22:41 INFO - rmtree: /builds/slave/test/build 20:22:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:22:41 INFO - Running post-action listener: _resource_record_post_action 20:22:41 INFO - ##### 20:22:41 INFO - ##### Finished clobber step (success) 20:22:41 INFO - ##### 20:22:41 INFO - ##### 20:22:41 INFO - ##### Running read-buildbot-config step. 20:22:41 INFO - ##### 20:22:41 INFO - Running pre-action listener: _resource_record_pre_action 20:22:41 INFO - Running main action method: read_buildbot_config 20:22:41 INFO - Using buildbot properties: 20:22:41 INFO - { 20:22:41 INFO - "project": "", 20:22:41 INFO - "product": "firefox", 20:22:41 INFO - "script_repo_revision": "production", 20:22:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:22:41 INFO - "repository": "", 20:22:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:22:41 INFO - "buildid": "20160606173007", 20:22:41 INFO - "pgo_build": "True", 20:22:41 INFO - "basedir": "/builds/slave/test", 20:22:41 INFO - "buildnumber": 816, 20:22:41 INFO - "slavename": "talos-linux64-ix-047", 20:22:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:22:41 INFO - "platform": "ubuntu64_hw", 20:22:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:22:41 INFO - "branch": "fx-team", 20:22:41 INFO - "repo_path": "integration/fx-team", 20:22:41 INFO - "revision": "d9f0b4e9a8add9e0931e1c549ccba22f7dbc67d3", 20:22:41 INFO - "stage_platform": "linux64-pgo", 20:22:41 INFO - "builduid": "9dd58ac981624fbb9c586a606df56dfe", 20:22:41 INFO - "slavebuilddir": "test" 20:22:41 INFO - } 20:22:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:22:41 INFO - Running post-action listener: _resource_record_post_action 20:22:41 INFO - ##### 20:22:41 INFO - ##### Finished read-buildbot-config step (success) 20:22:41 INFO - ##### 20:22:41 INFO - ##### 20:22:41 INFO - ##### Running download-and-extract step. 20:22:41 INFO - ##### 20:22:41 INFO - Running pre-action listener: _resource_record_pre_action 20:22:41 INFO - Running main action method: download_and_extract 20:22:41 INFO - mkdir: /builds/slave/test/build/tests 20:22: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')]} 20:22:41 INFO - https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:22:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:22:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:22:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/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 20:22:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/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 20:22:43 INFO - Downloaded 1361 bytes. 20:22:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:22:43 INFO - Using the following test package requirements: 20:22:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:22:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:22:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:43 INFO - u'jsshell-linux-x86_64.zip'], 20:22:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:22:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:22:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:22:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:22:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:22:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:22:43 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')]} 20:22:43 INFO - https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/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 20:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/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 20:22:44 INFO - Downloaded 24444211 bytes. 20:22:44 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'] 20:22:44 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 20:22:46 INFO - Return code: 0 20:22:46 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 20:22:46 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')]} 20:22:46 INFO - https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/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 20:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/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 20:22:48 INFO - Downloaded 24444211 bytes. 20:22:48 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'] 20:22:48 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 20:22:49 INFO - Return code: 0 20:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:49 INFO - https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:22:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/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 20:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/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 20:22:50 INFO - Downloaded 10833369 bytes. 20:22:50 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'] 20:22:50 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 20:22:50 INFO - Return code: 0 20:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:50 INFO - https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:22:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:22:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:22:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/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 20:22:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a8tDyd1PQrqA0w1kRzaQvw/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 20:22:52 INFO - Downloaded 59201948 bytes. 20:22:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:22:52 INFO - mkdir: /builds/slave/test/properties 20:22:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:22:52 INFO - Writing to file /builds/slave/test/properties/build_url 20:22:52 INFO - Contents: 20:22:52 INFO - build_url:https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:22:53 INFO - Running post-action listener: _resource_record_post_action 20:22:53 INFO - Running post-action listener: set_extra_try_arguments 20:22:53 INFO - ##### 20:22:53 INFO - ##### Finished download-and-extract step (success) 20:22:53 INFO - ##### 20:22:53 INFO - ##### 20:22:53 INFO - ##### Running populate-webroot step. 20:22:53 INFO - ##### 20:22:53 INFO - Running pre-action listener: _resource_record_pre_action 20:22:53 INFO - Running main action method: populate_webroot 20:22:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:22:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:22:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:22:53 INFO - '--tppagecycles', 20:22:53 INFO - '7'], 20:22:53 INFO - 'tests': ['tsvgm']}}, 20:22:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:22:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:22:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:22:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:22:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:22:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:22:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:53 INFO - 'talos_options': ['--disable-e10s'], 20:22:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:53 INFO - 'talos_options': ['--disable-e10s'], 20:22:53 INFO - 'tests': ['damp', 'tps']}, 20:22:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:53 INFO - 'tests': ['damp', 'tps']}, 20:22:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:22:53 INFO - 'tests': ['dromaeo_dom']}, 20:22:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:22:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:22:53 INFO - 'tests': ['a11yr', 20:22:53 INFO - 'ts_paint', 20:22:53 INFO - 'tpaint', 20:22:53 INFO - 'sessionrestore', 20:22:53 INFO - 'sessionrestore_no_auto_restore', 20:22:53 INFO - 'tabpaint']}, 20:22:53 INFO - 'other-e10s': {'tests': ['a11yr', 20:22:53 INFO - 'ts_paint', 20:22:53 INFO - 'tpaint', 20:22:53 INFO - 'sessionrestore', 20:22:53 INFO - 'sessionrestore_no_auto_restore', 20:22:53 INFO - 'tabpaint']}, 20:22:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:22:53 INFO - 'ts_paint', 20:22:53 INFO - 'tpaint', 20:22:53 INFO - 'sessionrestore', 20:22:53 INFO - 'sessionrestore_no_auto_restore', 20:22:53 INFO - 'tabpaint']}, 20:22:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:22:53 INFO - 'ts_paint', 20:22:53 INFO - 'tpaint', 20:22:53 INFO - 'sessionrestore', 20:22:53 INFO - 'sessionrestore_no_auto_restore', 20:22:53 INFO - 'tabpaint']}, 20:22:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:22:53 INFO - 'tests': ['a11yr', 20:22:53 INFO - 'ts_paint', 20:22:53 INFO - 'tpaint', 20:22:53 INFO - 'sessionrestore', 20:22:53 INFO - 'sessionrestore_no_auto_restore', 20:22:53 INFO - 'tabpaint']}, 20:22:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:22:53 INFO - 'tests': ['a11yr', 20:22:53 INFO - 'ts_paint', 20:22:53 INFO - 'tpaint', 20:22:53 INFO - 'sessionrestore', 20:22:53 INFO - 'sessionrestore_no_auto_restore', 20:22:53 INFO - 'tabpaint']}, 20:22:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:22:53 INFO - 'tests': ['tsvgx', 20:22:53 INFO - 'tsvgr_opacity', 20:22:53 INFO - 'tart', 20:22:53 INFO - 'tscrollx', 20:22:53 INFO - 'cart']}, 20:22:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:22:53 INFO - 'tsvgr_opacity', 20:22:53 INFO - 'tart', 20:22:53 INFO - 'tscrollx', 20:22:53 INFO - 'cart']}, 20:22:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:53 INFO - 'talos_options': ['--disable-e10s'], 20:22:53 INFO - 'tests': ['tp5o']}, 20:22:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:53 INFO - 'tests': ['tp5o']}, 20:22:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:53 INFO - 'talos_options': ['--disable-e10s', 20:22:53 INFO - '--xperf_path', 20:22:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:53 INFO - 'tests': ['tp5n']}, 20:22:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:53 INFO - 'talos_options': ['--xperf_path', 20:22:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:53 INFO - 'tests': ['tp5n']}}, 20:22:53 INFO - 'talos.zip': {'path': '', 20:22:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:22:53 INFO - Running post-action listener: _resource_record_post_action 20:22:53 INFO - ##### 20:22:53 INFO - ##### Finished populate-webroot step (success) 20:22:53 INFO - ##### 20:22:53 INFO - ##### 20:22:53 INFO - ##### Running create-virtualenv step. 20:22:53 INFO - ##### 20:22:53 INFO - Running pre-action listener: _resource_record_pre_action 20:22:53 INFO - Running main action method: create_virtualenv 20:22:53 INFO - Creating virtualenv /builds/slave/test/build/venv 20:22:53 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 20:22:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:22:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:22:53 INFO - Using real prefix '/usr' 20:22:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:22:53 INFO - Installing distribute.............................................................................................................................................................................................done. 20:22:55 INFO - Installing pip.................done. 20:22:55 INFO - Return code: 0 20:22:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a44f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aed00>, '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 0x12afab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aff60>, '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': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', '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 20:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:22:55 INFO - Using env: {'DISPLAY': ':0', 20:22:55 INFO - 'HOME': '/home/cltbld', 20:22:55 INFO - 'LANG': 'en_US.UTF-8', 20:22:55 INFO - 'LANGUAGE': 'en_US:en', 20:22:55 INFO - 'LOGNAME': 'cltbld', 20:22:55 INFO - 'MAIL': '/var/mail/cltbld', 20:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:55 INFO - 'MOZ_NO_REMOTE': '1', 20:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:55 INFO - 'NO_EM_RESTART': '1', 20:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:55 INFO - 'PWD': '/builds/slave/test', 20:22:55 INFO - 'SHELL': '/bin/bash', 20:22:55 INFO - 'SHLVL': '1', 20:22:55 INFO - 'TERM': 'linux', 20:22:55 INFO - 'TMOUT': '86400', 20:22:55 INFO - 'USER': 'cltbld', 20:22:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', 20:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:55 INFO - '_': '/tools/buildbot/bin/python'} 20:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:56 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 20:22:56 INFO - Cleaning up... 20:22:56 INFO - Return code: 0 20:22:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:56 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 0x7fe8a44f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aed00>, '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 0x12afab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aff60>, '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': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', '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 20:22:56 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 20:22:56 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 20:22:56 INFO - Using env: {'DISPLAY': ':0', 20:22:56 INFO - 'HOME': '/home/cltbld', 20:22:56 INFO - 'LANG': 'en_US.UTF-8', 20:22:56 INFO - 'LANGUAGE': 'en_US:en', 20:22:56 INFO - 'LOGNAME': 'cltbld', 20:22:56 INFO - 'MAIL': '/var/mail/cltbld', 20:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:56 INFO - 'MOZ_NO_REMOTE': '1', 20:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:56 INFO - 'NO_EM_RESTART': '1', 20:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:56 INFO - 'PWD': '/builds/slave/test', 20:22:56 INFO - 'SHELL': '/bin/bash', 20:22:56 INFO - 'SHLVL': '1', 20:22:56 INFO - 'TERM': 'linux', 20:22:56 INFO - 'TMOUT': '86400', 20:22:56 INFO - 'USER': 'cltbld', 20:22:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', 20:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:56 INFO - '_': '/tools/buildbot/bin/python'} 20:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:56 INFO - Downloading/unpacking psutil>=3.1.1 20:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:22:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:58 INFO - Installing collected packages: psutil 20:22:58 INFO - Running setup.py install for psutil 20:22:58 INFO - building 'psutil._psutil_linux' extension 20:22:58 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 20:22:58 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 20:22:58 INFO - building 'psutil._psutil_posix' extension 20:22:58 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 20:22:58 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 20:22:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:58 INFO - Successfully installed psutil 20:22:58 INFO - Cleaning up... 20:22:58 INFO - Return code: 0 20:22:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:58 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 0x7fe8a44f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aed00>, '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 0x12afab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aff60>, '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': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', '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 20:22:58 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 20:22:58 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 20:22:58 INFO - Using env: {'DISPLAY': ':0', 20:22:58 INFO - 'HOME': '/home/cltbld', 20:22:58 INFO - 'LANG': 'en_US.UTF-8', 20:22:58 INFO - 'LANGUAGE': 'en_US:en', 20:22:58 INFO - 'LOGNAME': 'cltbld', 20:22:58 INFO - 'MAIL': '/var/mail/cltbld', 20:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:58 INFO - 'MOZ_NO_REMOTE': '1', 20:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:58 INFO - 'NO_EM_RESTART': '1', 20:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:58 INFO - 'PWD': '/builds/slave/test', 20:22:58 INFO - 'SHELL': '/bin/bash', 20:22:58 INFO - 'SHLVL': '1', 20:22:58 INFO - 'TERM': 'linux', 20:22:58 INFO - 'TMOUT': '86400', 20:22:58 INFO - 'USER': 'cltbld', 20:22:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', 20:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:58 INFO - '_': '/tools/buildbot/bin/python'} 20:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:22:59 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 20:22:59 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 20:22:59 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 20:22:59 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 20:22:59 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 20:22:59 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 20:23:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:23:00 INFO - Installing collected packages: mozsystemmonitor 20:23:00 INFO - Running setup.py install for mozsystemmonitor 20:23:01 INFO - Successfully installed mozsystemmonitor 20:23:01 INFO - Cleaning up... 20:23:01 INFO - Return code: 0 20:23:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:01 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 0x7fe8a44f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aed00>, '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 0x12afab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aff60>, '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': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', '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 20:23:01 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 20:23:01 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 20:23:01 INFO - Using env: {'DISPLAY': ':0', 20:23:01 INFO - 'HOME': '/home/cltbld', 20:23:01 INFO - 'LANG': 'en_US.UTF-8', 20:23:01 INFO - 'LANGUAGE': 'en_US:en', 20:23:01 INFO - 'LOGNAME': 'cltbld', 20:23:01 INFO - 'MAIL': '/var/mail/cltbld', 20:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:01 INFO - 'MOZ_NO_REMOTE': '1', 20:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:01 INFO - 'NO_EM_RESTART': '1', 20:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:01 INFO - 'PWD': '/builds/slave/test', 20:23:01 INFO - 'SHELL': '/bin/bash', 20:23:01 INFO - 'SHLVL': '1', 20:23:01 INFO - 'TERM': 'linux', 20:23:01 INFO - 'TMOUT': '86400', 20:23:01 INFO - 'USER': 'cltbld', 20:23:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', 20:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:01 INFO - '_': '/tools/buildbot/bin/python'} 20:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:01 INFO - Downloading/unpacking jsonschema==2.5.1 20:23:01 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 20:23:01 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 20:23:01 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 20:23:01 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 20:23:01 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 20:23:01 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 20:23:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:23:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:23:03 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 20:23:03 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 20:23:03 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 20:23:03 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 20:23:03 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 20:23:03 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 20:23:03 INFO - Downloading functools32-3.2.3-2.tar.gz 20:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:23:03 INFO - warning: no files found matching '*.txt' 20:23:03 INFO - no previously-included directories found matching 'build' 20:23:03 INFO - no previously-included directories found matching 'dist' 20:23:03 INFO - no previously-included directories found matching '.git*' 20:23:03 INFO - Installing collected packages: jsonschema, functools32 20:23:03 INFO - Running setup.py install for functools32 20:23:03 INFO - warning: no files found matching '*.txt' 20:23:03 INFO - no previously-included directories found matching 'build' 20:23:03 INFO - no previously-included directories found matching 'dist' 20:23:03 INFO - no previously-included directories found matching '.git*' 20:23:03 INFO - Successfully installed jsonschema functools32 20:23:03 INFO - Cleaning up... 20:23:03 INFO - Return code: 0 20:23:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:03 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 0x7fe8a44f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aed00>, '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 0x12afab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aff60>, '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': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', '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 20:23:03 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 20:23:03 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 20:23:03 INFO - Using env: {'DISPLAY': ':0', 20:23:03 INFO - 'HOME': '/home/cltbld', 20:23:03 INFO - 'LANG': 'en_US.UTF-8', 20:23:03 INFO - 'LANGUAGE': 'en_US:en', 20:23:03 INFO - 'LOGNAME': 'cltbld', 20:23:03 INFO - 'MAIL': '/var/mail/cltbld', 20:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:03 INFO - 'MOZ_NO_REMOTE': '1', 20:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:03 INFO - 'NO_EM_RESTART': '1', 20:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:03 INFO - 'PWD': '/builds/slave/test', 20:23:03 INFO - 'SHELL': '/bin/bash', 20:23:03 INFO - 'SHLVL': '1', 20:23:03 INFO - 'TERM': 'linux', 20:23:03 INFO - 'TMOUT': '86400', 20:23:03 INFO - 'USER': 'cltbld', 20:23:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', 20:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:03 INFO - '_': '/tools/buildbot/bin/python'} 20:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:03 INFO - Downloading/unpacking blobuploader==1.2.4 20:23:03 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 20:23:03 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 20:23:03 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 20:23:03 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 20:23:03 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 20:23:03 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 20:23:05 INFO - Downloading blobuploader-1.2.4.tar.gz 20:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:23:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:23:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:06 INFO - Downloading docopt-0.6.1.tar.gz 20:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:23:06 INFO - Installing collected packages: blobuploader, requests, docopt 20:23:06 INFO - Running setup.py install for blobuploader 20:23:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:23:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:23:06 INFO - Running setup.py install for requests 20:23:07 INFO - Running setup.py install for docopt 20:23:07 INFO - Successfully installed blobuploader requests docopt 20:23:07 INFO - Cleaning up... 20:23:07 INFO - Return code: 0 20:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:23:07 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')]} 20:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:07 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')]} 20:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:07 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 0x7fe8a44f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aed00>, '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 0x12afab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aff60>, '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': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', '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 20:23:07 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 20:23:07 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 20:23:07 INFO - Using env: {'DISPLAY': ':0', 20:23:07 INFO - 'HOME': '/home/cltbld', 20:23:07 INFO - 'LANG': 'en_US.UTF-8', 20:23:07 INFO - 'LANGUAGE': 'en_US:en', 20:23:07 INFO - 'LOGNAME': 'cltbld', 20:23:07 INFO - 'MAIL': '/var/mail/cltbld', 20:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:07 INFO - 'MOZ_NO_REMOTE': '1', 20:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:07 INFO - 'NO_EM_RESTART': '1', 20:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:07 INFO - 'PWD': '/builds/slave/test', 20:23:07 INFO - 'SHELL': '/bin/bash', 20:23:07 INFO - 'SHLVL': '1', 20:23:07 INFO - 'TERM': 'linux', 20:23:07 INFO - 'TMOUT': '86400', 20:23:07 INFO - 'USER': 'cltbld', 20:23:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', 20:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:07 INFO - '_': '/tools/buildbot/bin/python'} 20:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:23:07 INFO - Running setup.py (path:/tmp/pip-GCnycC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:23:07 INFO - Running setup.py (path:/tmp/pip-w4lDju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:23:07 INFO - Running setup.py (path:/tmp/pip-apiYj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:23:07 INFO - Running setup.py (path:/tmp/pip-L5FWo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:23:07 INFO - Running setup.py (path:/tmp/pip-ymyJiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:23:07 INFO - Running setup.py (path:/tmp/pip-S1IaUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:23:07 INFO - Running setup.py (path:/tmp/pip-j97gCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:23:08 INFO - Running setup.py (path:/tmp/pip-mjiyrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:23:08 INFO - Running setup.py (path:/tmp/pip-wZ6kiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:23:08 INFO - Running setup.py (path:/tmp/pip-6d1Ywf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:23:08 INFO - Running setup.py (path:/tmp/pip-FDweDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:23:08 INFO - Running setup.py (path:/tmp/pip-e3f13t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:23:08 INFO - Running setup.py (path:/tmp/pip-obDZ6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:23:08 INFO - Running setup.py (path:/tmp/pip-geQ8c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:08 INFO - Running setup.py (path:/tmp/pip-pwnJFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:23:08 INFO - Running setup.py (path:/tmp/pip-xavIOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:23:08 INFO - Running setup.py (path:/tmp/pip-3mtAZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:23:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:23:08 INFO - Running setup.py install for manifestparser 20:23:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:23:08 INFO - Running setup.py install for mozcrash 20:23:08 INFO - Running setup.py install for mozdebug 20:23:09 INFO - Running setup.py install for mozdevice 20:23:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Running setup.py install for mozfile 20:23:09 INFO - Running setup.py install for mozhttpd 20:23:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Running setup.py install for mozinfo 20:23:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Running setup.py install for mozInstall 20:23:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Running setup.py install for mozleak 20:23:09 INFO - Running setup.py install for mozlog 20:23:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Running setup.py install for moznetwork 20:23:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Running setup.py install for mozprocess 20:23:10 INFO - Running setup.py install for mozprofile 20:23:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:23:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:23:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:23:10 INFO - Running setup.py install for mozrunner 20:23:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:23:10 INFO - Running setup.py install for mozscreenshot 20:23:10 INFO - Running setup.py install for moztest 20:23:10 INFO - Running setup.py install for mozversion 20:23:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:23:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:23:10 INFO - Cleaning up... 20:23:10 INFO - Return code: 0 20:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:10 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 0x7fe8a44f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aed00>, '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 0x12afab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aff60>, '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': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', '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 20:23:10 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 20:23:10 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 20:23:10 INFO - Using env: {'DISPLAY': ':0', 20:23:10 INFO - 'HOME': '/home/cltbld', 20:23:10 INFO - 'LANG': 'en_US.UTF-8', 20:23:10 INFO - 'LANGUAGE': 'en_US:en', 20:23:10 INFO - 'LOGNAME': 'cltbld', 20:23:10 INFO - 'MAIL': '/var/mail/cltbld', 20:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:10 INFO - 'MOZ_NO_REMOTE': '1', 20:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:10 INFO - 'NO_EM_RESTART': '1', 20:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:10 INFO - 'PWD': '/builds/slave/test', 20:23:10 INFO - 'SHELL': '/bin/bash', 20:23:10 INFO - 'SHLVL': '1', 20:23:10 INFO - 'TERM': 'linux', 20:23:10 INFO - 'TMOUT': '86400', 20:23:10 INFO - 'USER': 'cltbld', 20:23:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', 20:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:10 INFO - '_': '/tools/buildbot/bin/python'} 20:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:23:10 INFO - Running setup.py (path:/tmp/pip-0cVuHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:23:10 INFO - Running setup.py (path:/tmp/pip-_4ElB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:23:10 INFO - Running setup.py (path:/tmp/pip-3aGrjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:23:11 INFO - Running setup.py (path:/tmp/pip-w0wQZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:23:11 INFO - Running setup.py (path:/tmp/pip-EPDdzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:23:11 INFO - Running setup.py (path:/tmp/pip-zpLakc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:23:11 INFO - Running setup.py (path:/tmp/pip-xE1usQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:23:11 INFO - Running setup.py (path:/tmp/pip-3ejcXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:23:11 INFO - Running setup.py (path:/tmp/pip-5fq_T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:23:11 INFO - Running setup.py (path:/tmp/pip-AWBowq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:23:11 INFO - Running setup.py (path:/tmp/pip-Xc0VjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:23:11 INFO - Running setup.py (path:/tmp/pip-ZrQ_Rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:23:11 INFO - Running setup.py (path:/tmp/pip-jAxD4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:23:11 INFO - Running setup.py (path:/tmp/pip-tnkIpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:11 INFO - Running setup.py (path:/tmp/pip-LsP8Km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:23:11 INFO - Running setup.py (path:/tmp/pip-nEN2Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:23:11 INFO - Running setup.py (path:/tmp/pip-VfV0o6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:23:12 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)) 20:23:12 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)) 20:23:12 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)) 20:23:12 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)) 20:23:12 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)) 20:23:12 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)) 20:23:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:23:12 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 20:23:12 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 20:23:12 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 20:23:12 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 20:23:12 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 20:23:12 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 20:23:13 INFO - Downloading blessings-1.6.tar.gz 20:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:23:14 INFO - Installing collected packages: blessings 20:23:14 INFO - Running setup.py install for blessings 20:23:14 INFO - Successfully installed blessings 20:23:14 INFO - Cleaning up... 20:23:14 INFO - Return code: 0 20:23:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:23:14 INFO - Reading from file tmpfile_stdout 20:23:14 INFO - Current package versions: 20:23:14 INFO - argparse == 1.2.1 20:23:14 INFO - blessings == 1.6 20:23:14 INFO - blobuploader == 1.2.4 20:23:14 INFO - docopt == 0.6.1 20:23:14 INFO - functools32 == 3.2.3-2 20:23:14 INFO - jsonschema == 2.5.1 20:23:14 INFO - manifestparser == 1.1 20:23:14 INFO - mozInstall == 1.12 20:23:14 INFO - mozcrash == 0.17 20:23:14 INFO - mozdebug == 0.1 20:23:14 INFO - mozdevice == 0.48 20:23:14 INFO - mozfile == 1.2 20:23:14 INFO - mozhttpd == 0.7 20:23:14 INFO - mozinfo == 0.9 20:23:14 INFO - mozleak == 0.1 20:23:14 INFO - mozlog == 3.2 20:23:14 INFO - moznetwork == 0.27 20:23:14 INFO - mozprocess == 0.22 20:23:14 INFO - mozprofile == 0.28 20:23:14 INFO - mozrunner == 6.11 20:23:14 INFO - mozscreenshot == 0.1 20:23:14 INFO - mozsystemmonitor == 0.3 20:23:14 INFO - moztest == 0.7 20:23:14 INFO - mozversion == 1.4 20:23:14 INFO - psutil == 3.1.1 20:23:14 INFO - requests == 1.2.3 20:23:14 INFO - wsgiref == 0.1.2 20:23:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:14 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 0x7fe8a44f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aed00>, '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 0x12afab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aff60>, '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': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', '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 20:23:14 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 20:23:14 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 20:23:14 INFO - Using env: {'DISPLAY': ':0', 20:23:14 INFO - 'HOME': '/home/cltbld', 20:23:14 INFO - 'LANG': 'en_US.UTF-8', 20:23:14 INFO - 'LANGUAGE': 'en_US:en', 20:23:14 INFO - 'LOGNAME': 'cltbld', 20:23:14 INFO - 'MAIL': '/var/mail/cltbld', 20:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:14 INFO - 'MOZ_NO_REMOTE': '1', 20:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:14 INFO - 'NO_EM_RESTART': '1', 20:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:14 INFO - 'PWD': '/builds/slave/test', 20:23:14 INFO - 'SHELL': '/bin/bash', 20:23:14 INFO - 'SHLVL': '1', 20:23:14 INFO - 'TERM': 'linux', 20:23:14 INFO - 'TMOUT': '86400', 20:23:14 INFO - 'USER': 'cltbld', 20:23:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', 20:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:14 INFO - '_': '/tools/buildbot/bin/python'} 20:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:14 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)) 20:23:14 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)) 20:23:14 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)) 20:23:14 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)) 20:23:14 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)) 20:23:14 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)) 20:23:14 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)) 20:23:14 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)) 20:23:14 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)) 20:23:14 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)) 20:23:14 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)) 20:23:14 INFO - Cleaning up... 20:23:14 INFO - Return code: 0 20:23:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:14 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 0x7fe8a44f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aed00>, '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 0x12afab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aff60>, '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': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', '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 20:23:14 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 20:23:14 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 20:23:14 INFO - Using env: {'DISPLAY': ':0', 20:23:14 INFO - 'HOME': '/home/cltbld', 20:23:14 INFO - 'LANG': 'en_US.UTF-8', 20:23:14 INFO - 'LANGUAGE': 'en_US:en', 20:23:14 INFO - 'LOGNAME': 'cltbld', 20:23:14 INFO - 'MAIL': '/var/mail/cltbld', 20:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:14 INFO - 'MOZ_NO_REMOTE': '1', 20:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:14 INFO - 'NO_EM_RESTART': '1', 20:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:14 INFO - 'PWD': '/builds/slave/test', 20:23:14 INFO - 'SHELL': '/bin/bash', 20:23:14 INFO - 'SHLVL': '1', 20:23:14 INFO - 'TERM': 'linux', 20:23:14 INFO - 'TMOUT': '86400', 20:23:14 INFO - 'USER': 'cltbld', 20:23:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', 20:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:14 INFO - '_': '/tools/buildbot/bin/python'} 20:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:23:14 INFO - Cleaning up... 20:23:14 INFO - Return code: 0 20:23:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:14 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 0x7fe8a44f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aed00>, '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 0x12afab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aff60>, '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': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', '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 20:23:14 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 20:23:14 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 20:23:14 INFO - Using env: {'DISPLAY': ':0', 20:23:14 INFO - 'HOME': '/home/cltbld', 20:23:14 INFO - 'LANG': 'en_US.UTF-8', 20:23:14 INFO - 'LANGUAGE': 'en_US:en', 20:23:14 INFO - 'LOGNAME': 'cltbld', 20:23:14 INFO - 'MAIL': '/var/mail/cltbld', 20:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:14 INFO - 'MOZ_NO_REMOTE': '1', 20:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:14 INFO - 'NO_EM_RESTART': '1', 20:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:14 INFO - 'PWD': '/builds/slave/test', 20:23:14 INFO - 'SHELL': '/bin/bash', 20:23:14 INFO - 'SHLVL': '1', 20:23:14 INFO - 'TERM': 'linux', 20:23:14 INFO - 'TMOUT': '86400', 20:23:14 INFO - 'USER': 'cltbld', 20:23:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', 20:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:14 INFO - '_': '/tools/buildbot/bin/python'} 20:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:15 INFO - Downloading/unpacking flake8 20:23:15 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 20:23:15 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 20:23:15 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 20:23:15 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 20:23:15 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 20:23:15 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 20:23:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:23:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:23:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:23:17 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 20:23:17 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 20:23:17 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 20:23:17 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 20:23:17 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 20:23:17 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 20:23:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:23:17 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 20:23:17 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 20:23:17 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 20:23:17 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 20:23:17 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 20:23:17 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 20:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:23:17 INFO - no previously-included directories found matching 'docs/_build' 20:23:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:23:17 INFO - Running setup.py install for pep8 20:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:23:17 INFO - no previously-included directories found matching 'docs/_build' 20:23:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:23:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:23:17 INFO - Cleaning up... 20:23:17 INFO - Return code: 0 20:23:17 INFO - Running post-action listener: _resource_record_post_action 20:23:17 INFO - Running post-action listener: _start_resource_monitoring 20:23:17 INFO - Starting resource monitoring. 20:23:17 INFO - ##### 20:23:17 INFO - ##### Finished create-virtualenv step (success) 20:23:17 INFO - ##### 20:23:17 INFO - ##### 20:23:17 INFO - ##### Running install step. 20:23:17 INFO - ##### 20:23:17 INFO - Running pre-action listener: _resource_record_pre_action 20:23:17 INFO - Running main action method: install 20:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:23:18 INFO - Reading from file tmpfile_stdout 20:23:18 INFO - Detecting whether we're running mozinstall >=1.0... 20:23:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:23:18 INFO - Reading from file tmpfile_stdout 20:23:18 INFO - Output received: 20:23:18 INFO - Usage: mozinstall [options] installer 20:23:18 INFO - Options: 20:23:18 INFO - -h, --help show this help message and exit 20:23:18 INFO - -d DEST, --destination=DEST 20:23:18 INFO - Directory to install application into. [default: 20:23:18 INFO - "/builds/slave/test"] 20:23:18 INFO - --app=APP Application being installed. [default: firefox] 20:23:18 INFO - mkdir: /builds/slave/test/build/application 20:23:18 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'] 20:23:18 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 20:23:35 INFO - Reading from file tmpfile_stdout 20:23:35 INFO - Output received: 20:23:35 INFO - /builds/slave/test/build/application/firefox/firefox 20:23:35 INFO - Running post-action listener: _resource_record_post_action 20:23:35 INFO - ##### 20:23:35 INFO - ##### Finished install step (success) 20:23:35 INFO - ##### 20:23:35 INFO - ##### 20:23:35 INFO - ##### Running run-tests step. 20:23:35 INFO - ##### 20:23:35 INFO - Running pre-action listener: _resource_record_pre_action 20:23:35 INFO - Running main action method: run_tests 20:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:23:35 INFO - Python 2.7.3 20:23:35 INFO - Return code: 0 20:23:35 INFO - grabbing minidump binary from tooltool 20:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:35 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 0x12aed00>, '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 0x12afab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aff60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:23:35 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 20:23:35 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 20:23:35 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 20:23:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:23:35 INFO - Return code: 0 20:23:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:23:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:23:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:23:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:23:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:23:36 INFO - Return code: 0 20:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 20:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 20:23:36 INFO - Using env: {'DISPLAY': ':0', 20:23:36 INFO - 'HOME': '/home/cltbld', 20:23:36 INFO - 'LANG': 'en_US.UTF-8', 20:23:36 INFO - 'LANGUAGE': 'en_US:en', 20:23:36 INFO - 'LOGNAME': 'cltbld', 20:23:36 INFO - 'MAIL': '/var/mail/cltbld', 20:23:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:23:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:36 INFO - 'MOZ_NO_REMOTE': '1', 20:23:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:36 INFO - 'NO_EM_RESTART': '1', 20:23:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:36 INFO - 'PWD': '/builds/slave/test', 20:23:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:23:36 INFO - 'SHELL': '/bin/bash', 20:23:36 INFO - 'SHLVL': '1', 20:23:36 INFO - 'TERM': 'linux', 20:23:36 INFO - 'TMOUT': '86400', 20:23:36 INFO - 'USER': 'cltbld', 20:23:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367', 20:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:36 INFO - '_': '/tools/buildbot/bin/python'} 20:23:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 20:23:36 INFO - mozversion application_buildid: 20160606173007 20:23:36 INFO - mozversion application_changeset: d9f0b4e9a8add9e0931e1c549ccba22f7dbc67d3 20:23:36 INFO - mozversion application_display_name: Nightly 20:23:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:23:36 INFO - mozversion application_name: Firefox 20:23:36 INFO - mozversion application_remotingname: firefox 20:23:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:23:36 INFO - mozversion application_vendor: Mozilla 20:23:36 INFO - mozversion application_version: 50.0a1 20:23:36 INFO - mozversion platform_buildid: 20160606173007 20:23:36 INFO - mozversion platform_changeset: d9f0b4e9a8add9e0931e1c549ccba22f7dbc67d3 20:23:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:23:36 INFO - mozversion platform_version: 50.0a1 20:23:36 INFO - using testdate: 1465269816 20:23:36 INFO - actual date: 1465269816 20:23:36 INFO - starting webserver on 'localhost:59895' 20:23:36 INFO - SUITE-START | Running 2 tests 20:23:36 INFO - TEST-START | dromaeo_css 20:23:36 INFO - operating with platform_type : linux_ 20:23:36 INFO - Initialising browser for dromaeo_css test... 20:23:36 INFO - TEST-INFO | started process 5861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvLYuJM/profile http://localhost:59895/getInfo.html) 20:23:40 INFO - PROCESS | 5861 | __metrics Screen width/height:1600/1200 20:23:40 INFO - PROCESS | 5861 | colorDepth:24 20:23:40 INFO - PROCESS | 5861 | Browser inner width/height: 1024/697 20:23:40 INFO - PROCESS | 5861 | __metrics 20:23:41 ERROR - PROCESS | 5861 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 20:23:42 INFO - TEST-INFO | 5861: exit 0 20:23:42 INFO - Browser initialized. 20:23:42 INFO - Running cycle 1/1 for dromaeo_css test... 20:23:42 INFO - TEST-INFO | started process 5983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvLYuJM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:54 INFO - PROCESS | 5983 | RSS: Main: 167075840 20:23:54 INFO - PROCESS | 5983 | 20:24:43 INFO - PROCESS | 5983 | 1465269883845 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] 20:26:51 INFO - PROCESS | 5983 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59895/tests/dromaeo/cssquery-ext.html) 20:26:52 INFO - PROCESS | 5983 | RSS: Main: 170991616 20:26:52 INFO - PROCESS | 5983 | 20:29:54 INFO - PROCESS | 5983 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-ext.html (next: http://localhost:59895/tests/dromaeo/cssquery-jquery.html) 20:29:55 INFO - PROCESS | 5983 | RSS: Main: 170569728 20:29:55 INFO - PROCESS | 5983 | 20:32:57 INFO - PROCESS | 5983 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59895/tests/dromaeo/cssquery-mootools.html) 20:32:57 INFO - PROCESS | 5983 | RSS: Main: 171364352 20:32:57 INFO - PROCESS | 5983 | 20:35:59 INFO - PROCESS | 5983 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59895/tests/dromaeo/cssquery-prototype.html) 20:36:00 INFO - PROCESS | 5983 | RSS: Main: 169074688 20:36:00 INFO - PROCESS | 5983 | 20:39:02 INFO - PROCESS | 5983 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59895/tests/dromaeo/cssquery-yui.html) 20:39:03 INFO - PROCESS | 5983 | RSS: Main: 171155456 20:39:03 INFO - PROCESS | 5983 | 20:42:05 INFO - PROCESS | 5983 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-yui.html (next: http://localhost:59895/tests/dromaeo/cssquery-dojo.html) 20:42:05 INFO - PROCESS | 5983 | RSS: Main: 172044288 20:42:05 INFO - PROCESS | 5983 | 20:42:05 INFO - PROCESS | 5983 | __start_tp_report 20:42:05 INFO - PROCESS | 5983 | _x_x_mozilla_page_load 20:42:05 INFO - PROCESS | 5983 | _x_x_mozilla_page_load_details 20:42:05 INFO - PROCESS | 5983 | |i|pagename|runs| 20:42:05 INFO - PROCESS | 5983 | |0;dojo.html;3096.6903309669037;3154.9526757098633;3185.219621192808;3203.9519407208895;3204.2470019545403;5580.358258800234;5583.776648934043;5602.07565751651;5685.488306052454;5715;5559.054960656688;5641.323041235048;5690.743916523756;5692.686902220376;5727.284089488814;5087.211482220262;5122.6926384416865;5239.13554263546;5251.448597897223;5291.047611429941;649.5953487537454;5229.163333866582;5234.26720259164;5253.369595648527;5256.316678831747;5113.590912726973;5143.048536020848;5159.71621560814;5166.199239117943;5236.188390799432;5041.495850414965;5161.66449180802;5167.121589329823;5172.482751724798;5179.663321884065;5104.081265372231;5152.845414637567;5171.637985341028;5184.844454666366;5205.297284866532;5603.635763675348;5638.605297629127;5643.492085712305;5652.491275785199;5697.829065128053;5946.554008449383;5958.374370691102;6132.448079672851;6141.969290153565;6144;6000.069989151689;6126.724297406628;6137.447629713302;6137.9079313810325;6143.447089761943;5636.15457681347;5675.659460432346;5687.033204355311;5687.544996400278;5689.886202275931;6019.668918209453;6151.200343955257;6154.569180157436;6225.657588832658;6251.562390632703;6041.124037014608;6047.516198704093;6052.757889684452;6055.061465472859;6090.756369745249;6058.666773327421;6089.512838972872;6114.510839132859;6115.327313995457;6165.753369865245;5922.644641321448;5986.940130598726;6005.849853753603;6053.636781793107;6103.511719062464;5912.083627037816;6031.5476339273855;6043.456088952015;6092.482139018144;6107.175531303217;4575.062112266977;4593.035462552834;4600.493945665974;4604.516525764813;4652.55800698933;3978.4430179774854;4027.033511957109;4063.187362527506;4077.938830917539;4099.057216840143;5804.448577385142;5808.796692115756;5814.796482123105;5856.736446859902;5890.322612899571;6047.637141771508;6164.907526387108;6177.7837775677635;6178.104174894705;6199.070139479024;5689.431056894277;5774.797882074107;5795.043817770021;5844.444777746107;5855.063189889597;5246.606504512177;5247.63266571344;5252.816151434681;5272.340957380327;5280.683159010472;6349.301576826545;6378.649174295366;6395.424411802867;6396.808095757135;6397.10440538325;5963.135345374896;6042.879142417215;6092;6123.571350005457;6162.506999440124;6259.092431597484;6263.060540918898;6310.810675679737;6315.90526142099;6332.30344662096;5799.594028417971;5975.16347711312;6006.279246490274;6017.638941663514;6038.335783063947;6069.180660610938;6087.786927457518;6119.595344370343;6142.385761423822;6177.62934223948;6005;6005.159277701213;6017.398260173947;6032.336442991355;6061.575689701855;5769.884602308014;5838.182654428469;5981.910271346021;5988.4909782668965;6008.218931539047;5702.971485142548;5709.685967271674;5782.2194003808945;5816.854578635568;5895.67573783446;5893.616914900518;5958.076498142795;5987.700614969147;5990.910136348046;6010.849728756816;5580.609357344947;5831.533477321889;5841.240638716939;5849.824505264849;5871.295444546682 20:42:05 INFO - PROCESS | 5983 | |1;ext.html;570.9514691251244;587.6797145555673;606.2543072021414;607.0075426677381;631.0691729698696;43919.34120988184;45200.32199517006;45357.77321113394;45406.54593454064;48427.51572484274;46096;46518.30222546664;46925.765371173184;46972.29541556879;47069.76465117678;8629.482231066157;8836.42563233391;8843.690470833522;8846.071162527938;8858.512781796999;8861.689840855572;8969.416987895765;8973.865392019125;8978.326625503081;8982;8998.730038098867;9005.369624126313;9010.414323068979;9019.23336516397;9025.458472491639;8826.24976876963;8859.379843410963;8937.597808098652;8947.821043579124;8954.462732236087;8866.73399798007;8947.373683842134;8979.14698103679;8985.550722463917;9000.279977601776;41619.37570936439;42153;42355.1528969422;42367;42438;3547.166415892289;3687.631236876318;3774.2828862516035;4002.8398864045403;4072.124493233939;32022.519662205086;32350.191245218823;32689;32975.50536741927;33421;4078.449409329732;4133.689973252018;4218.472690913636;4245.363195520666;4266.189424009459;370899;371728;373730.1313493442;374374;374941;59658.70170649119;59811;59847.40152598506;60050.699746500984;60200.39799601948;35337.823310883796;36087.63912360843;36289.45565816515;38472.80763596164;38513.614863851006;14329.498467553585;14347.78478322826;14363.64090897715;14369.56891293263;14434.278286085864;11768.823467647991;11812.822807657893;11829;11841.111916606289;11887.583934562248;19656.606867862847;19849.503762406057;19923.800761992195;20055.498612534513;20086.497837553885;7148.177959534616;7165.820854478576;7171.569705817667;7371;7403.444741644291;985.2265971212707;1045.1795340657548;1080.2762149359949;1114.6321713834416;1196.5752157983964;32074.19814504656;32490.837545812592;32740.181495462803;33060.1734956628;33761.15597110092;1139.8974092331564;1159.9710007249716;1161.9825702614467;1191.7854786138578;1205.6684411786828;17294.913525432294;17431.47705568835;17615.471535853943;17663.470095897144;17666.823331766518;614732;617216;625412;627528;629077;56942.7152864233;57875.710621446626;58229;58299.12551311734;58515.70742146262;1339.9531016414378;1369.897257705676;1376.490698441583;1387.2370196391944;1391.5199256256576;30569.847150764104;31841.522377164823;32195;32207.677923220468;32863;51999;52282.73858630683;52468.47531524636;52476.73761631167;52525;476807;485926;486523;486675;490217;28031.299217519725;28203.15390538287;28492.857535713018;28500.287492812015;28617;48153.277700833816;48274.275885862444;48825.267620985;49641.751791240815;49691.50308496869;40662.79668601638;41558.376624351265;42108.15783684248;42432.78783606062;42571.57428425676;41743.58256417397;41759;41886.37170442385;42609;42777.358339624305;42033.78983105065;44997.55002450065;45727;46278.30582541332;46339.76830115828;40784.1843163141;41004.1799164021;42596;43577;44137.55862441463;33927.830360848035;33997.49003764995;34423.655763442046;34426.655733443346;34686.65313346834 20:42:05 INFO - PROCESS | 5983 | |2;jquery.html;391.7923500544712;397.3523157253676;401.2416532753097;401.4921124777159;415.63424186715685;13907.860921390784;18459.169337379815;18975.810241897576;19751.11119999598;20057;18392.35626753064;18835.62328753424;19067.618647627074;19097.61804763904;19236;5391.78432862685;5684.943150568482;5687.886242275152;5700.230468886699;5930.258717660293;5251;5522.30971128609;5689.914651280214;5693.373728889839;5747.511461525754;5558.638688485255;5575.972120139394;5586.888262234753;5587.664740115586;5601;5912.674802885839;6347.270063942637;6505.804825855208;6511;6517.120188774502;5568.220449137124;5628.212050312959;5673.914891276634;5798.507126894219;5807.970960145214;12499.812502812465;12787.61637150887;13076.280804555745;13097.541586044443;13208.801867971988;2251.853629514076;2348.998264944474;2409.795167410772;2449.64480150379;2457.348802567321;10153.238507111997;10347.637832675895;10483.161347092215;10601.204909631808;14457.349419276157;1825.9452216433529;1843.2442698493553;1864.822841830024;1870.186468886039;1875.1749230338608;78472.60763696203;78810.21189788086;79303.20696793016;79911;80332.57339412833;9032.774180645405;9795.755106122262;9798.412095274307;9850.950745246228;10839.241253112365;13108.868911310765;13138.737225255632;13262.801057984138;13277;13312.467501300032;7459.216782237895;7569.924300757032;7703.845923081507;7811.687532498637;7819.569923654253;7478.364339031244;7531.623418829036;7624.961875190588;7719.305262526287;7749.961250193825;4079.326911059642;4082.510098788105;4117.485314335708;4142.668586513072;4198.6221240088535;1974.6840505519049;1983.652860749363;2044.376465178135;2049.333966460906;2077.0994539996036;944.5418971798672;981.1316984468797;981.3670182732097;1073.5330131392868;1089.9073578745895;16801.327946882233;18208.544786380447;18588;20012.89993550023;20155.19379224844;990.2226751999646;999.6501224571488;1039.3711804358406;1074.6238816414193;1088.3415533602215;9288.256939444827;10761.730956726144;10837.512311945824;10851.945740271249;10897.019268265894;445608;451853;472198;474126;474286;59682.10476842851;80745;99765.50117249368;99936;102643;1039.9740006499899;1055.6305293147336;1057.9365238085738;1069.534752382716;1072.0405237312561;17206.741898871776;17949.282028718706;18018.36935707244;18245;18283.54291142732;42794;43072.78463607662;43119.485569013756;43928.56071439245;44812;51949.480505194464;59343;60791;61328;62440.37559624527;8003.959980200062;8607.741767746978;8712.164748564608;8785.604647790737;8891.644334226818;9565.473898935625;12814.167079139826;13164.078514503894;13236.073474856668;13250.933745331211;11179.832302515306;11408.258463199865;11605.6518304451;11874.821877672015;12089.939550302191;11397.772044558897;11399.373034483184;11434.256773309708;11489.655310340702;11494.54021839117;11639.418029098342;11826.526938922347;11937.82093268619;12018.579349722717;12054.879451205376;8143.226393492609;8187.549684767157;8345.768971626927;8724.956375218084;8787.780305492413;8439.746807595537;10470.633527826794;11461.140414468782;11751.647450576496;11899.524019039141 20:42:05 INFO - PROCESS | 5983 | |3;mootools.html;1486.1083349990008;1531.7778922056298;1670.3986564836657;1812.7099664053753;1816.4823025437752;7993.120756716757;8621.180987806165;8686.913130868705;9223.30825188111;9233.49215793131;8768.254698350633;9066.320025998044;9118.498482583454;9139.817203655923;9148.947870994838;2415.311636183688;2450.1669432392982;2454.6563481112657;2455;2455.533448644752;2400.807935365175;2418.37122348189;2449.7060352757694;2455.545724041049;2459.188467805629;2375.8099352051795;2390.5935990881503;2403.555342261687;2416.6979127609047;2421.116292553223;2359.2096647623066;2387.8209134315;2400.5558971590312;2403.2910291463972;2408.3015925381706;2376.9524609507885;2390.820688448356;2413.8431001984814;2420.9031638734427;2422.9757702422926;8955.776105597348;9038.728838134866;9047.366684332099;9055.320850936141;9069.54652267384;5411.269478620376;5536.252605898192;5592.245046918654;5596.412376700469;5601.691906945116;3311.8012919224925;3436.4501679731375;3533.770304930197;3536.398812201906;3550.9112272193142;1206.3184300870068;1231.7105480212142;1235.3761350517932;1262.482382223284;1285.3380509037852;12683.74632507354;12776.999999999907;12799.808002879965;12803.743925121538;12943.67640808978;4701.78841952113;4862.78117484714;4948.752562371867;4960.330355402047;4970.8757281068265;10779.461026948622;10819.296745711503;10819.459027048617;10825.242233043611;10840.72898177536;5501.642393244426;5508.55931525485;5508.7521061552325;5514.448555144534;5529.640573362719;4475.686701930834;4851.927221091686;5038.924416133761;5049.267856160836;5069.949300507022;4098.262312783668;4165.58344165581;4169.3120635094865;4185.066987956591;4244.787760611957;1316.7432350691522;1348.5145347675025;1354.823872896517;1362.7514600908382;1373.986260137386;966.294604938399;993.6025589764153;995.8356871116184;996.2030375699411;1000.364768372089;5902.734376952962;5930.970345148333;5957.374475680078;6013.6993150342305;6103.450689437972;448.428253976183;452.57005844447906;453.71869440946165;1056.8309070548676;1095.906847917936;4046.2109888571445;4048.5748996355546;4100.897477563085;4157.584241575818;4169.291220492523;10962.506687199095;11254.043406310555;11277.830832537518;11309.943450282695;11322.26405283654;10970;11158.1631377647;11163.832542511705;11183.552657893755;11192.664220073411;8316.958415207764;8355;8437.451565648213;8484.109168537214;8518.87221691675;5804.709764511842;5875.265591801025;5905.852353691021;5992.221011268507;6011.068284415923;10144.137748291478;10293.176545876462;10511.474426278808;10548.789024219319;10550.841737373792;10392.844107338547;10485.842712359168;10642.73393165177;10760.139188864716;10767.515461804081;7726.729564465217;7917.722879699183;7978.401619878417;7988.081370642218;8163.387745919199;8813.867791982997;8828.382013259266;8856.335774817044;8864.42381245217;8872.24585910205;7874.921250787648;8160.551169685724;8184.672613095409;8355.331573473986;8372.455790373606;7919.802004949923;8044.758657240292;8132.796680082809;8214.301784348158;8268.627911744106;7054.294570542905;7083.574985500886;7182.4613154014705;7221.350078492751;7300.744473943387;5195.882885179704;5228.477152284741;5382.3541175059245;5391.8382448525035;5475.616706830484;5454.536364408911;5473.972630136824;5553.18027701266;5640.971795140998;5680.488756011979 20:42:05 INFO - PROCESS | 5983 | |4;prototype.html;317.9300553878147;320.8973128598848;325.234073756304;326.186165517035;329.05889157010944;5578.219049333086;5645.322561292651;5648.576356773243;5741.2536370271855;5772.595918285721;5568.331800183983;5681.431856814316;5701.57238207134;5724.8855022899625;5725.7995970141055;4398.692091553593;4408.823647054114;4413.779311034452;4420.31485119807;4444.111177764444;4166.437530933315;4213.136307057046;4274.615284624383;4296.742195468266;4322.178786030644;4284.2930916398755;4297.548757380477;4342.544032876534;4357.825686972533;4374.278244089722;4375.934360984587;4383.605475507204;4398.780060996969;4399.780010999437;4416.205083085043;3805.6194380561724;3805.8667946621736;3846.8461261549505;3847.384418493056;3856.6529012388737;5314.574834013309;5363.597730170214;5369.81205657804;5422.295101636762;5430.972845135789;4943.752812359404;4965.280034394992;4999.32509111269;5000.924986125175;5013.699178049293;5509.025126431722;5852.385499522574;5867.11993201019;5871.148683440877;5892.790203673622;4219.620234178908;4225.260579398593;4233.978830105861;4239.47006624172;4243.236217480852;5930.258717660336;6055.818325450244;6093.482054025369;6145.955187618116;6183.165272688175;4347.891302717458;4348.826046958149;4359.716618419792;4361.760103194291;4361.847335343247;4420.447444069491;4421.756803375845;4435.401220835211;4437.29003359461;4450.46594408673;5030.597552195889;5035.16919708244;5052.57053150479;5059.215821547666;5066.6453348266;5775.393583673654;5860.648361098348;5964.7315870785915;5979.9402005980255;6027.8794424111275;1511.6749898771598;1524.1769444499846;1524.4511975688742;1540.4762380790585;1547.860692537677;934.1825902335456;979.9461029643295;984.5963155106515;988.1156365053237;996.3872218585662;5052.722100284446;5072.199369223946;5626.409227031185;5719.456651618089;5752.194692742935;6087.482563982023;6101.542384321194;6142.600730952474;6174.413430724164;6179;5541.224228607998;5747.827565173052;5844.824655260349;5887.499562537147;5919.141724449931;3254.576905002382;3276.836158192081;3288.8293726140632;3298.8185649789493;3319.7344212462945;6284.4344009039405;6305.716242768995;6329.449284925223;6352.841178970562;6455.644939528277;5999.610025348338;6141.788955975845;6165.599236049642;6237.313895471494;6248.50011999039;6332.208473940757;6335.429811316912;6359.759846829824;6374.840628984312;6392.4246817786625;5930.8056019273145;6056.57603967718;6160.907586386118;6180.969095154675;6250.718717657625;6074.757009719562;6081.452669259788;6110.755569777337;6137.60105593135;6149.292831324455;6066.968615335315;6321.683915804283;6398.776042838478;6401.327860574573;6416.967915160394;4233.555476674905;4268.445102136827;4280.571942805695;4292.871213863589;4297.72064815786;6113.755449782137;6130.969345153246;6152.692365381802;6160.843704703318;6164.722587483664;5841.386654401226;5915.940840591711;6005.699715014144;6009.36901625323;6016.315431679137;5934.7922822701;5942.64344139353;5952.345242023461;5959.851003724942;5972.5520585955355;5847.912281315698;5851.502622276984;5853.531717462678;5868.332292317302;5884.529237661062;5776.624519406225;5987.9401205989125;6037.366076562073;6042.667653279112;6050.757969681164;5907.438793314628;5939.376365481735;5940.930632486194;5942.6731529766275;5945.791897283574 20:42:05 INFO - PROCESS | 5983 | |5;yui.html;731.7621772923794;742.3059439424139;757.2805834457267;833.0752864320604;860.9655613775449;15017.39930402784;15427.768583471243;15669.921650391761;15735.055896646196;15745.763813542806;14506;14653.853461465382;14737.852621473781;14819.77770333446;14856.55430337089;666.3969107957306;789.3211837819471;791.5844181804556;810.1493431896486;812.3947658994058;799.0451410564378;801.819590592118;805.8549461097;806.4274365200714;807.6163822184474;854.4318028511063;856.7943693513574;857.237059017475;860.956952152393;862.3273846399787;844.7465760271893;848.0078308379211;849.5964416901984;854.0221446443818;854.444611002847;618.774147436187;620.3362402229616;622.747787146202;623.0560700538688;624.865653884417;15388.53834384959;15402;15468.767968480483;15501.534953951399;15582.142982135978;15175.241237938058;15243.771343429857;15410;15464.768028479582;15619.765703514457;12651.557195498113;12671.556495522613;12741.17182383142;12767.170133941265;12800.551980680724;3913.5695073541888;3944.467496887912;3970.583088775666;4068.6948478863906;4132.40080188371;64020;67283.3271667282;67568.3243167567;72786.90819637763;82365.58817205875;11457.966106744383;11732.530698771954;11795.646130616095;11989.340586267665;12286.385680715928;21176.682349764767;21306.78693213079;21327.36017919465;21370.679439808417;21426.571468570542;8945.910540894638;8956.238719708768;9048.321375896834;9087.636494540277;9275.814483710423;4709.62323014158;4713.6936099153445;4770.260609605517;4783.545563171493;4828.855134345975;3751.5498140222803;3857.787821669835;3868.2650296443585;3872;3883.7863917484246;653.5523166630873;669.7321071571313;681.6762038031994;682.607500687107;690.9585424874524;710.137183322266;710.8827043537862;712.7220384050224;720.4164626652429;722.9204787473374;8595.441296315845;8973.775655608662;9004.36969412148;9218.354715169873;9293.95353023244;655.7672026430644;660.0429377402785;666.2970566052861;689.183317768446;719.5790462579449;4315.201687687788;4398.3842262083335;4492.438445194351;4524.47968483622;4565.977170114194;66766.33233667698;66980.33019669741;109891;112848.43575782068;115434.422827887;58523;59016;60389.69805150946;99317;100542;54495.72752136214;74504.62747686227;88451.55774221088;90882.54558727297;91249.54375228082;8849.557522123996;8922.86615700778;9104.681336153202;9109.498977556297;9155.908440915771;40603.59396405998;52489;53785.46214537961;53985.46014539804;55519.444805553045;75038.62480687561;77637.61181194057;79695.60152199202;79725;80189.1981080205;10742.3017503862;11044.392558409043;11174.776504469703;11214.383208923588;11329.150313726339;12343.567975120828;12691.619251422471;12938.159019664068;13272.469101235842;13316;11620.883791162318;11626.186166968231;11884.702882428008;11914.225575337576;11966.521339146337;11111;11417.37204453763;11564.537418503165;11832.17174797756;11993.640190793942;11003.669889903316;11372.20394572372;11508.769824603629;11539.249948753304;11554.76890462203;8932.821343573221;8973.730788076367;9010.774730631787;9153.542322883963;9249.352545322032;8262.215089566482;8676.826463470821;8997.550122493718;9195.448273103635;9552.092551207625 20:42:05 INFO - PROCESS | 5983 | __end_tp_report 20:42:05 INFO - PROCESS | 5983 | __start_cc_report 20:42:05 INFO - PROCESS | 5983 | _x_x_mozilla_cycle_collect,354 20:42:05 INFO - PROCESS | 5983 | __end_cc_report 20:42:05 INFO - PROCESS | 5983 | __startTimestamp1465270925845__endTimestamp 20:42:05 INFO - PROCESS | 5983 | 20:42:05 INFO - PROCESS | 5983 | ------- Summary: start ------- 20:42:05 INFO - PROCESS | 5983 | Number of tests: 6 20:42:05 INFO - PROCESS | 5983 | 20:42:05 INFO - PROCESS | 5983 | [#0] dojo.html Cycles:165 Average:5616.92 Median:5855.06 stddev:771.35 (13.2%) stddev-sans-first:747.95 20:42:05 INFO - PROCESS | 5983 | Values: 3096.7 3155.0 3185.2 3204.0 3204.2 5580.4 5583.8 5602.1 5685.5 5715.0 5559.1 5641.3 5690.7 5692.7 5727.3 5087.2 5122.7 5239.1 5251.4 5291.0 649.6 5229.2 5234.3 5253.4 5256.3 5113.6 5143.0 5159.7 5166.2 5236.2 5041.5 5161.7 5167.1 5172.5 5179.7 5104.1 5152.8 5171.6 5184.8 5205.3 5603.6 5638.6 5643.5 5652.5 5697.8 5946.6 5958.4 6132.4 6142.0 6144.0 6000.1 6126.7 6137.4 6137.9 6143.4 5636.2 5675.7 5687.0 5687.5 5689.9 6019.7 6151.2 6154.6 6225.7 6251.6 6041.1 6047.5 6052.8 6055.1 6090.8 6058.7 6089.5 6114.5 6115.3 6165.8 5922.6 5986.9 6005.8 6053.6 6103.5 5912.1 6031.5 6043.5 6092.5 6107.2 4575.1 4593.0 4600.5 4604.5 4652.6 3978.4 4027.0 4063.2 4077.9 4099.1 5804.4 5808.8 5814.8 5856.7 5890.3 6047.6 6164.9 6177.8 6178.1 6199.1 5689.4 5774.8 5795.0 5844.4 5855.1 5246.6 5247.6 5252.8 5272.3 5280.7 6349.3 6378.6 6395.4 6396.8 6397.1 5963.1 6042.9 6092.0 6123.6 6162.5 6259.1 6263.1 6310.8 6315.9 6332.3 5799.6 5975.2 6006.3 6017.6 6038.3 6069.2 6087.8 6119.6 6142.4 6177.6 6005.0 6005.2 6017.4 6032.3 6061.6 5769.9 5838.2 5981.9 5988.5 6008.2 5703.0 5709.7 5782.2 5816.9 5895.7 5893.6 5958.1 5987.7 5990.9 6010.8 5580.6 5831.5 5841.2 5849.8 5871.3 20:42:05 INFO - PROCESS | 5983 | 20:42:05 INFO - PROCESS | 5983 | [#1] ext.html Cycles:180 Average:64755.78 Median:42435.39 stddev:134247.09 (316.4%) stddev-sans-first:134537.19 20:42:05 INFO - PROCESS | 5983 | Values: 571.0 587.7 606.3 607.0 631.1 43919.3 45200.3 45357.8 45406.5 48427.5 46096.0 46518.3 46925.8 46972.3 47069.8 8629.5 8836.4 8843.7 8846.1 8858.5 8861.7 8969.4 8973.9 8978.3 8982.0 8998.7 9005.4 9010.4 9019.2 9025.5 8826.2 8859.4 8937.6 8947.8 8954.5 8866.7 8947.4 8979.1 8985.6 9000.3 41619.4 42153.0 42355.2 42367.0 42438.0 3547.2 3687.6 3774.3 4002.8 4072.1 32022.5 32350.2 32689.0 32975.5 33421.0 4078.4 4133.7 4218.5 4245.4 4266.2 370899.0 371728.0 373730.1 374374.0 374941.0 59658.7 59811.0 59847.4 60050.7 60200.4 35337.8 36087.6 36289.5 38472.8 38513.6 14329.5 14347.8 14363.6 14369.6 14434.3 11768.8 11812.8 11829.0 11841.1 11887.6 19656.6 19849.5 19923.8 20055.5 20086.5 7148.2 7165.8 7171.6 7371.0 7403.4 985.2 1045.2 1080.3 1114.6 1196.6 32074.2 32490.8 32740.2 33060.2 33761.2 1139.9 1160.0 1162.0 1191.8 1205.7 17294.9 17431.5 17615.5 17663.5 17666.8 614732.0 617216.0 625412.0 627528.0 629077.0 56942.7 57875.7 58229.0 58299.1 58515.7 1340.0 1369.9 1376.5 1387.2 1391.5 30569.8 31841.5 32195.0 32207.7 32863.0 51999.0 52282.7 52468.5 52476.7 52525.0 476807.0 485926.0 486523.0 486675.0 490217.0 28031.3 28203.2 28492.9 28500.3 28617.0 48153.3 48274.3 48825.3 49641.8 49691.5 40662.8 41558.4 42108.2 42432.8 42571.6 41743.6 41759.0 41886.4 42609.0 42777.4 42033.8 44997.6 45727.0 46278.3 46339.8 40784.2 41004.2 42596.0 43577.0 44137.6 33927.8 33997.5 34423.7 34426.7 34686.7 20:42:05 INFO - PROCESS | 5983 | 20:42:05 INFO - PROCESS | 5983 | [#2] jquery.html Cycles:180 Average:27754.57 Median:399.30 stddev:76658.12 (19198.3%) stddev-sans-first:76845.63 20:42:05 INFO - PROCESS | 5983 | Values: 391.8 397.4 401.2 401.5 415.6 13907.9 18459.2 18975.8 19751.1 20057.0 18392.4 18835.6 19067.6 19097.6 19236.0 5391.8 5684.9 5687.9 5700.2 5930.3 5251.0 5522.3 5689.9 5693.4 5747.5 5558.6 5576.0 5586.9 5587.7 5601.0 5912.7 6347.3 6505.8 6511.0 6517.1 5568.2 5628.2 5673.9 5798.5 5808.0 12499.8 12787.6 13076.3 13097.5 13208.8 2251.9 2349.0 2409.8 2449.6 2457.3 10153.2 10347.6 10483.2 10601.2 14457.3 1825.9 1843.2 1864.8 1870.2 1875.2 78472.6 78810.2 79303.2 79911.0 80332.6 9032.8 9795.8 9798.4 9851.0 10839.2 13108.9 13138.7 13262.8 13277.0 13312.5 7459.2 7569.9 7703.8 7811.7 7819.6 7478.4 7531.6 7625.0 7719.3 7750.0 4079.3 4082.5 4117.5 4142.7 4198.6 1974.7 1983.7 2044.4 2049.3 2077.1 944.5 981.1 981.4 1073.5 1089.9 16801.3 18208.5 18588.0 20012.9 20155.2 990.2 999.7 1039.4 1074.6 1088.3 9288.3 10761.7 10837.5 10851.9 10897.0 445608.0 451853.0 472198.0 474126.0 474286.0 59682.1 80745.0 99765.5 99936.0 102643.0 1040.0 1055.6 1057.9 1069.5 1072.0 17206.7 17949.3 18018.4 18245.0 18283.5 42794.0 43072.8 43119.5 43928.6 44812.0 51949.5 59343.0 60791.0 61328.0 62440.4 8004.0 8607.7 8712.2 8785.6 8891.6 9565.5 12814.2 13164.1 13236.1 13250.9 11179.8 11408.3 11605.7 11874.8 12089.9 11397.8 11399.4 11434.3 11489.7 11494.5 11639.4 11826.5 11937.8 12018.6 12054.9 8143.2 8187.5 8345.8 8725.0 8787.8 8439.7 10470.6 11461.1 11751.6 11899.5 20:42:05 INFO - PROCESS | 5983 | 20:42:05 INFO - PROCESS | 5983 | [#3] mootools.html Cycles:180 Average:5998.70 Median:453.14 stddev:3409.67 (752.4%) stddev-sans-first:3402.37 20:42:05 INFO - PROCESS | 5983 | Values: 1486.1 1531.8 1670.4 1812.7 1816.5 7993.1 8621.2 8686.9 9223.3 9233.5 8768.3 9066.3 9118.5 9139.8 9148.9 2415.3 2450.2 2454.7 2455.0 2455.5 2400.8 2418.4 2449.7 2455.5 2459.2 2375.8 2390.6 2403.6 2416.7 2421.1 2359.2 2387.8 2400.6 2403.3 2408.3 2377.0 2390.8 2413.8 2420.9 2423.0 8955.8 9038.7 9047.4 9055.3 9069.5 5411.3 5536.3 5592.2 5596.4 5601.7 3311.8 3436.5 3533.8 3536.4 3550.9 1206.3 1231.7 1235.4 1262.5 1285.3 12683.7 12777.0 12799.8 12803.7 12943.7 4701.8 4862.8 4948.8 4960.3 4970.9 10779.5 10819.3 10819.5 10825.2 10840.7 5501.6 5508.6 5508.8 5514.4 5529.6 4475.7 4851.9 5038.9 5049.3 5069.9 4098.3 4165.6 4169.3 4185.1 4244.8 1316.7 1348.5 1354.8 1362.8 1374.0 966.3 993.6 995.8 996.2 1000.4 5902.7 5931.0 5957.4 6013.7 6103.5 448.4 452.6 453.7 1056.8 1095.9 4046.2 4048.6 4100.9 4157.6 4169.3 10962.5 11254.0 11277.8 11309.9 11322.3 10970.0 11158.2 11163.8 11183.6 11192.7 8317.0 8355.0 8437.5 8484.1 8518.9 5804.7 5875.3 5905.9 5992.2 6011.1 10144.1 10293.2 10511.5 10548.8 10550.8 10392.8 10485.8 10642.7 10760.1 10767.5 7726.7 7917.7 7978.4 7988.1 8163.4 8813.9 8828.4 8856.3 8864.4 8872.2 7874.9 8160.6 8184.7 8355.3 8372.5 7919.8 8044.8 8132.8 8214.3 8268.6 7054.3 7083.6 7182.5 7221.4 7300.7 5195.9 5228.5 5382.4 5391.8 5475.6 5454.5 5474.0 5553.2 5641.0 5680.5 20:42:05 INFO - PROCESS | 5983 | 20:42:05 INFO - PROCESS | 5983 | [#4] prototype.html Cycles:180 Average:4995.24 Median:5750.01 stddev:1485.08 (25.8%) stddev-sans-first:1447.16 20:42:05 INFO - PROCESS | 5983 | Values: 317.9 320.9 325.2 326.2 329.1 5578.2 5645.3 5648.6 5741.3 5772.6 5568.3 5681.4 5701.6 5724.9 5725.8 4398.7 4408.8 4413.8 4420.3 4444.1 4166.4 4213.1 4274.6 4296.7 4322.2 4284.3 4297.5 4342.5 4357.8 4374.3 4375.9 4383.6 4398.8 4399.8 4416.2 3805.6 3805.9 3846.8 3847.4 3856.7 5314.6 5363.6 5369.8 5422.3 5431.0 4943.8 4965.3 4999.3 5000.9 5013.7 5509.0 5852.4 5867.1 5871.1 5892.8 4219.6 4225.3 4234.0 4239.5 4243.2 5930.3 6055.8 6093.5 6146.0 6183.2 4347.9 4348.8 4359.7 4361.8 4361.8 4420.4 4421.8 4435.4 4437.3 4450.5 5030.6 5035.2 5052.6 5059.2 5066.6 5775.4 5860.6 5964.7 5979.9 6027.9 1511.7 1524.2 1524.5 1540.5 1547.9 934.2 979.9 984.6 988.1 996.4 5052.7 5072.2 5626.4 5719.5 5752.2 6087.5 6101.5 6142.6 6174.4 6179.0 5541.2 5747.8 5844.8 5887.5 5919.1 3254.6 3276.8 3288.8 3298.8 3319.7 6284.4 6305.7 6329.4 6352.8 6455.6 5999.6 6141.8 6165.6 6237.3 6248.5 6332.2 6335.4 6359.8 6374.8 6392.4 5930.8 6056.6 6160.9 6181.0 6250.7 6074.8 6081.5 6110.8 6137.6 6149.3 6067.0 6321.7 6398.8 6401.3 6417.0 4233.6 4268.4 4280.6 4292.9 4297.7 6113.8 6131.0 6152.7 6160.8 6164.7 5841.4 5915.9 6005.7 6009.4 6016.3 5934.8 5942.6 5952.3 5959.9 5972.6 5847.9 5851.5 5853.5 5868.3 5884.5 5776.6 5987.9 6037.4 6042.7 6050.8 5907.4 5939.4 5940.9 5942.7 5945.8 20:42:05 INFO - PROCESS | 5983 | 20:42:05 INFO - PROCESS | 5983 | [#5] yui.html Cycles:180 Average:19031.21 Median:58769.50 stddev:26851.24 (45.7%) stddev-sans-first:26891.40 20:42:05 INFO - PROCESS | 5983 | Values: 731.8 742.3 757.3 833.1 861.0 15017.4 15427.8 15669.9 15735.1 15745.8 14506.0 14653.9 14737.9 14819.8 14856.6 666.4 789.3 791.6 810.1 812.4 799.0 801.8 805.9 806.4 807.6 854.4 856.8 857.2 861.0 862.3 844.7 848.0 849.6 854.0 854.4 618.8 620.3 622.7 623.1 624.9 15388.5 15402.0 15468.8 15501.5 15582.1 15175.2 15243.8 15410.0 15464.8 15619.8 12651.6 12671.6 12741.2 12767.2 12800.6 3913.6 3944.5 3970.6 4068.7 4132.4 64020.0 67283.3 67568.3 72786.9 82365.6 11458.0 11732.5 11795.6 11989.3 12286.4 21176.7 21306.8 21327.4 21370.7 21426.6 8945.9 8956.2 9048.3 9087.6 9275.8 4709.6 4713.7 4770.3 4783.5 4828.9 3751.5 3857.8 3868.3 3872.0 3883.8 653.6 669.7 681.7 682.6 691.0 710.1 710.9 712.7 720.4 722.9 8595.4 8973.8 9004.4 9218.4 9294.0 655.8 660.0 666.3 689.2 719.6 4315.2 4398.4 4492.4 4524.5 4566.0 66766.3 66980.3 109891.0 112848.4 115434.4 58523.0 59016.0 60389.7 99317.0 100542.0 54495.7 74504.6 88451.6 90882.5 91249.5 8849.6 8922.9 9104.7 9109.5 9155.9 40603.6 52489.0 53785.5 53985.5 55519.4 75038.6 77637.6 79695.6 79725.0 80189.2 10742.3 11044.4 11174.8 11214.4 11329.2 12343.6 12691.6 12938.2 13272.5 13316.0 11620.9 11626.2 11884.7 11914.2 11966.5 11111.0 11417.4 11564.5 11832.2 11993.6 11003.7 11372.2 11508.8 11539.2 11554.8 8932.8 8973.7 9010.8 9153.5 9249.4 8262.2 8676.8 8997.6 9195.4 9552.1 20:42:05 INFO - PROCESS | 5983 | -------- Summary: end -------- 20:42:05 INFO - PROCESS | 5983 | 20:42:06 INFO - TEST-INFO | 5983: exit 0 20:42:06 INFO - TEST-OK | dromaeo_css | took 1110346ms 20:42:06 INFO - TEST-START | kraken 20:42:06 INFO - operating with platform_type : linux_ 20:42:06 INFO - Initialising browser for kraken test... 20:42:06 INFO - TEST-INFO | started process 6209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfnvlnM/profile http://localhost:59895/getInfo.html) 20:42:11 INFO - PROCESS | 6209 | __metrics Screen width/height:1600/1200 20:42:11 INFO - PROCESS | 6209 | colorDepth:24 20:42:11 INFO - PROCESS | 6209 | Browser inner width/height: 1024/697 20:42:11 INFO - PROCESS | 6209 | __metrics 20:42:11 ERROR - PROCESS | 6209 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 20:42:12 INFO - TEST-INFO | 6209: exit 0 20:42:12 INFO - Browser initialized. 20:42:12 INFO - Running cycle 1/1 for kraken test... 20:42:12 INFO - TEST-INFO | started process 6332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfnvlnM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:42:24 INFO - PROCESS | 6332 | RSS: Main: 167555072 20:42:24 INFO - PROCESS | 6332 | 20:42:26 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59895/tests/kraken/driver.html?testName=audio-beat-detection) 20:42:27 INFO - PROCESS | 6332 | RSS: Main: 172486656 20:42:27 INFO - PROCESS | 6332 | 20:42:30 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59895/tests/kraken/driver.html?testName=audio-dft) 20:42:31 INFO - PROCESS | 6332 | RSS: Main: 171843584 20:42:31 INFO - PROCESS | 6332 | 20:42:34 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59895/tests/kraken/driver.html?testName=audio-fft) 20:42:34 INFO - PROCESS | 6332 | RSS: Main: 166748160 20:42:34 INFO - PROCESS | 6332 | 20:42:37 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59895/tests/kraken/driver.html?testName=audio-oscillator) 20:42:37 INFO - PROCESS | 6332 | RSS: Main: 167612416 20:42:37 INFO - PROCESS | 6332 | 20:42:39 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59895/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:42:40 INFO - PROCESS | 6332 | RSS: Main: 168210432 20:42:40 INFO - PROCESS | 6332 | 20:42:43 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59895/tests/kraken/driver.html?testName=imaging-darkroom) 20:42:44 INFO - PROCESS | 6332 | RSS: Main: 168689664 20:42:44 INFO - PROCESS | 6332 | 20:42:47 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59895/tests/kraken/driver.html?testName=imaging-desaturate) 20:42:48 INFO - PROCESS | 6332 | RSS: Main: 168648704 20:42:48 INFO - PROCESS | 6332 | 20:42:51 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59895/tests/kraken/driver.html?testName=json-parse-financial) 20:42:51 INFO - PROCESS | 6332 | RSS: Main: 168378368 20:42:51 INFO - PROCESS | 6332 | 20:42:53 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59895/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:42:53 INFO - PROCESS | 6332 | RSS: Main: 168443904 20:42:53 INFO - PROCESS | 6332 | 20:42:55 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:42:56 INFO - PROCESS | 6332 | RSS: Main: 168763392 20:42:56 INFO - PROCESS | 6332 | 20:42:58 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:42:59 INFO - PROCESS | 6332 | RSS: Main: 169246720 20:42:59 INFO - PROCESS | 6332 | 20:43:01 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:43:02 INFO - PROCESS | 6332 | RSS: Main: 168902656 20:43:02 INFO - PROCESS | 6332 | 20:43:05 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:43:05 INFO - PROCESS | 6332 | RSS: Main: 168755200 20:43:05 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59895/tests/kraken/driver.html?testName=ai-astar) 20:43:07 INFO - PROCESS | 6332 | RSS: Main: 169312256 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | __start_tp_report 20:43:07 INFO - PROCESS | 6332 | _x_x_mozilla_page_load 20:43:07 INFO - PROCESS | 6332 | _x_x_mozilla_page_load_details 20:43:07 INFO - PROCESS | 6332 | |i|pagename|runs| 20:43:07 INFO - PROCESS | 6332 | |0;ai-astar;113;108;111;112;111;112;109;110;112;111 20:43:07 INFO - PROCESS | 6332 | |1;audio-beat-detection;159;127;160;175;128;161;160;134;192;127 20:43:07 INFO - PROCESS | 6332 | |2;audio-dft;163;163;162;162;162;165;168;163;164;163 20:43:07 INFO - PROCESS | 6332 | |3;audio-fft;75;75;77;179;76;75;77;75;155;77 20:43:07 INFO - PROCESS | 6332 | |4;audio-oscillator;85;85;140;86;86;86;141;85;85;149 20:43:07 INFO - PROCESS | 6332 | |5;imaging-gaussian-blur;118;118;119;117;118;119;117;118;118;117 20:43:07 INFO - PROCESS | 6332 | |6;imaging-darkroom;146;146;148;149;147;148;147;147;147;147 20:43:07 INFO - PROCESS | 6332 | |7;imaging-desaturate;98;96;96;96;96;95;95;96;96;96 20:43:07 INFO - PROCESS | 6332 | |8;json-parse-financial;57;53;54;53;56;61;53;52;53;52 20:43:07 INFO - PROCESS | 6332 | |9;json-stringify-tinderbox;62;62;61;63;62;62;62;62;63;62 20:43:07 INFO - PROCESS | 6332 | |10;stanford-crypto-aes;80;81;80;83;83;82;82;81;106;80 20:43:07 INFO - PROCESS | 6332 | |11;stanford-crypto-ccm;126;129;131;134;124;134;123;128;133;141 20:43:07 INFO - PROCESS | 6332 | |12;stanford-crypto-pbkdf2;163;161;167;157;162;163;162;161;162;163 20:43:07 INFO - PROCESS | 6332 | |13;stanford-crypto-sha256-iterative;65;64;65;66;65;62;62;63;63;62 20:43:07 INFO - PROCESS | 6332 | __end_tp_report 20:43:07 INFO - PROCESS | 6332 | __start_cc_report 20:43:07 INFO - PROCESS | 6332 | _x_x_mozilla_cycle_collect,875 20:43:07 INFO - PROCESS | 6332 | __end_cc_report 20:43:07 INFO - PROCESS | 6332 | __startTimestamp1465270987594__endTimestamp 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | ------- Summary: start ------- 20:43:07 INFO - PROCESS | 6332 | Number of tests: 14 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.52 (1.4%) stddev-sans-first:1.41 20:43:07 INFO - PROCESS | 6332 | Values: 113.0 108.0 111.0 112.0 111.0 112.0 109.0 110.0 112.0 111.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:160.00 stddev:22.45 (14.0%) stddev-sans-first:23.68 20:43:07 INFO - PROCESS | 6332 | Values: 159.0 127.0 160.0 175.0 128.0 161.0 160.0 134.0 192.0 127.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:1.84 (1.1%) stddev-sans-first:1.94 20:43:07 INFO - PROCESS | 6332 | Values: 163.0 163.0 162.0 162.0 162.0 165.0 168.0 163.0 164.0 163.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:38.85 (51.5%) stddev-sans-first:40.58 20:43:07 INFO - PROCESS | 6332 | Values: 75.0 75.0 77.0 179.0 76.0 75.0 77.0 75.0 155.0 77.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:85.00 stddev:28.07 (33.0%) stddev-sans-first:29.02 20:43:07 INFO - PROCESS | 6332 | Values: 85.0 85.0 140.0 86.0 86.0 86.0 141.0 85.0 85.0 149.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 20:43:07 INFO - PROCESS | 6332 | Values: 118.0 118.0 119.0 117.0 118.0 119.0 117.0 118.0 118.0 117.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 20:43:07 INFO - PROCESS | 6332 | Values: 146.0 146.0 148.0 149.0 147.0 148.0 147.0 147.0 147.0 147.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.44 20:43:07 INFO - PROCESS | 6332 | Values: 98.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.50 stddev:2.84 (5.3%) stddev-sans-first:2.85 20:43:07 INFO - PROCESS | 6332 | Values: 57.0 53.0 54.0 53.0 56.0 61.0 53.0 52.0 53.0 52.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 20:43:07 INFO - PROCESS | 6332 | Values: 62.0 62.0 61.0 63.0 62.0 62.0 62.0 62.0 63.0 62.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:81.50 stddev:7.89 (9.7%) stddev-sans-first:8.24 20:43:07 INFO - PROCESS | 6332 | Values: 80.0 81.0 80.0 83.0 83.0 82.0 82.0 81.0 106.0 80.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:132.00 stddev:5.46 (4.1%) stddev-sans-first:5.56 20:43:07 INFO - PROCESS | 6332 | Values: 126.0 129.0 131.0 134.0 124.0 134.0 123.0 128.0 133.0 141.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:162.50 stddev:2.47 (1.5%) stddev-sans-first:2.60 20:43:07 INFO - PROCESS | 6332 | Values: 163.0 161.0 167.0 157.0 162.0 163.0 162.0 161.0 162.0 163.0 20:43:07 INFO - PROCESS | 6332 | 20:43:07 INFO - PROCESS | 6332 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.50 stddev:1.49 (2.3%) stddev-sans-first:1.51 20:43:07 INFO - PROCESS | 6332 | Values: 65.0 64.0 65.0 66.0 65.0 62.0 62.0 63.0 63.0 62.0 20:43:07 INFO - PROCESS | 6332 | -------- Summary: end -------- 20:43:07 INFO - PROCESS | 6332 | 20:43:08 INFO - TEST-INFO | 6332: exit 0 20:43:08 INFO - TEST-OK | kraken | took 61904ms 20:43:08 INFO - SUITE-END | took 1172s 20:43:08 INFO - Completed test suite (00:19:32) 20:43:08 INFO - javascript benchmark 20:43:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7361.130516935335, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.6903309669037, 3154.9526757098633, 3185.219621192808, 3203.9519407208895, 3204.2470019545403, 5580.358258800234, 5583.776648934043, 5602.07565751651, 5685.488306052454, 5715.0, 5559.054960656688, 5641.323041235048, 5690.743916523756, 5692.686902220376, 5727.284089488814, 5087.211482220262, 5122.6926384416865, 5239.13554263546, 5251.448597897223, 5291.047611429941, 649.5953487537454, 5229.163333866582, 5234.26720259164, 5253.369595648527, 5256.316678831747, 5113.590912726973, 5143.048536020848, 5159.71621560814, 5166.199239117943, 5236.188390799432, 5041.495850414965, 5161.66449180802, 5167.121589329823, 5172.482751724798, 5179.663321884065, 5104.081265372231, 5152.845414637567, 5171.637985341028, 5184.844454666366, 5205.297284866532, 5603.635763675348, 5638.605297629127, 5643.492085712305, 5652.491275785199, 5697.829065128053, 5946.554008449383, 5958.374370691102, 6132.448079672851, 6141.969290153565, 6144.0, 6000.069989151689, 6126.724297406628, 6137.447629713302, 6137.9079313810325, 6143.447089761943, 5636.15457681347, 5675.659460432346, 5687.033204355311, 5687.544996400278, 5689.886202275931, 6019.668918209453, 6151.200343955257, 6154.569180157436, 6225.657588832658, 6251.562390632703, 6041.124037014608, 6047.516198704093, 6052.757889684452, 6055.061465472859, 6090.756369745249, 6058.666773327421, 6089.512838972872, 6114.510839132859, 6115.327313995457, 6165.753369865245, 5922.644641321448, 5986.940130598726, 6005.849853753603, 6053.636781793107, 6103.511719062464, 5912.083627037816, 6031.5476339273855, 6043.456088952015, 6092.482139018144, 6107.175531303217, 4575.062112266977, 4593.035462552834, 4600.493945665974, 4604.516525764813, 4652.55800698933, 3978.4430179774854, 4027.033511957109, 4063.187362527506, 4077.938830917539, 4099.057216840143, 5804.448577385142, 5808.796692115756, 5814.796482123105, 5856.736446859902, 5890.322612899571, 6047.637141771508, 6164.907526387108, 6177.7837775677635, 6178.104174894705, 6199.070139479024, 5689.431056894277, 5774.797882074107, 5795.043817770021, 5844.444777746107, 5855.063189889597, 5246.606504512177, 5247.63266571344, 5252.816151434681, 5272.340957380327, 5280.683159010472, 6349.301576826545, 6378.649174295366, 6395.424411802867, 6396.808095757135, 6397.10440538325, 5963.135345374896, 6042.879142417215, 6092.0, 6123.571350005457, 6162.506999440124, 6259.092431597484, 6263.060540918898, 6310.810675679737, 6315.90526142099, 6332.30344662096, 5799.594028417971, 5975.16347711312, 6006.279246490274, 6017.638941663514, 6038.335783063947, 6069.180660610938, 6087.786927457518, 6119.595344370343, 6142.385761423822, 6177.62934223948, 6005.0, 6005.159277701213, 6017.398260173947, 6032.336442991355, 6061.575689701855, 5769.884602308014, 5838.182654428469, 5981.910271346021, 5988.4909782668965, 6008.218931539047, 5702.971485142548, 5709.685967271674, 5782.2194003808945, 5816.854578635568, 5895.67573783446, 5893.616914900518, 5958.076498142795, 5987.700614969147, 5990.910136348046, 6010.849728756816, 5580.609357344947, 5831.533477321889, 5841.240638716939, 5849.824505264849, 5871.295444546682], "value": 5564.523427565879, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.9514691251244, 587.6797145555673, 606.2543072021414, 607.0075426677381, 631.0691729698696, 43919.34120988184, 45200.32199517006, 45357.77321113394, 45406.54593454064, 48427.51572484274, 46096.0, 46518.30222546664, 46925.765371173184, 46972.29541556879, 47069.76465117678, 8629.482231066157, 8836.42563233391, 8843.690470833522, 8846.071162527938, 8858.512781796999, 8861.689840855572, 8969.416987895765, 8973.865392019125, 8978.326625503081, 8982.0, 8998.730038098867, 9005.369624126313, 9010.414323068979, 9019.23336516397, 9025.458472491639, 8826.24976876963, 8859.379843410963, 8937.597808098652, 8947.821043579124, 8954.462732236087, 8866.73399798007, 8947.373683842134, 8979.14698103679, 8985.550722463917, 9000.279977601776, 41619.37570936439, 42153.0, 42355.1528969422, 42367.0, 42438.0, 3547.166415892289, 3687.631236876318, 3774.2828862516035, 4002.8398864045403, 4072.124493233939, 32022.519662205086, 32350.191245218823, 32689.0, 32975.50536741927, 33421.0, 4078.449409329732, 4133.689973252018, 4218.472690913636, 4245.363195520666, 4266.189424009459, 370899.0, 371728.0, 373730.1313493442, 374374.0, 374941.0, 59658.70170649119, 59811.0, 59847.40152598506, 60050.699746500984, 60200.39799601948, 35337.823310883796, 36087.63912360843, 36289.45565816515, 38472.80763596164, 38513.614863851006, 14329.498467553585, 14347.78478322826, 14363.64090897715, 14369.56891293263, 14434.278286085864, 11768.823467647991, 11812.822807657893, 11829.0, 11841.111916606289, 11887.583934562248, 19656.606867862847, 19849.503762406057, 19923.800761992195, 20055.498612534513, 20086.497837553885, 7148.177959534616, 7165.820854478576, 7171.569705817667, 7371.0, 7403.444741644291, 985.2265971212707, 1045.1795340657548, 1080.2762149359949, 1114.6321713834416, 1196.5752157983964, 32074.19814504656, 32490.837545812592, 32740.181495462803, 33060.1734956628, 33761.15597110092, 1139.8974092331564, 1159.9710007249716, 1161.9825702614467, 1191.7854786138578, 1205.6684411786828, 17294.913525432294, 17431.47705568835, 17615.471535853943, 17663.470095897144, 17666.823331766518, 614732.0, 617216.0, 625412.0, 627528.0, 629077.0, 56942.7152864233, 57875.710621446626, 58229.0, 58299.12551311734, 58515.70742146262, 1339.9531016414378, 1369.897257705676, 1376.490698441583, 1387.2370196391944, 1391.5199256256576, 30569.847150764104, 31841.522377164823, 32195.0, 32207.677923220468, 32863.0, 51999.0, 52282.73858630683, 52468.47531524636, 52476.73761631167, 52525.0, 476807.0, 485926.0, 486523.0, 486675.0, 490217.0, 28031.299217519725, 28203.15390538287, 28492.857535713018, 28500.287492812015, 28617.0, 48153.277700833816, 48274.275885862444, 48825.267620985, 49641.751791240815, 49691.50308496869, 40662.79668601638, 41558.376624351265, 42108.15783684248, 42432.78783606062, 42571.57428425676, 41743.58256417397, 41759.0, 41886.37170442385, 42609.0, 42777.358339624305, 42033.78983105065, 44997.55002450065, 45727.0, 46278.30582541332, 46339.76830115828, 40784.1843163141, 41004.1799164021, 42596.0, 43577.0, 44137.55862441463, 33927.830360848035, 33997.49003764995, 34423.655763442046, 34426.655733443346, 34686.65313346834], "value": 20452.800519215274, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.7923500544712, 397.3523157253676, 401.2416532753097, 401.4921124777159, 415.63424186715685, 13907.860921390784, 18459.169337379815, 18975.810241897576, 19751.11119999598, 20057.0, 18392.35626753064, 18835.62328753424, 19067.618647627074, 19097.61804763904, 19236.0, 5391.78432862685, 5684.943150568482, 5687.886242275152, 5700.230468886699, 5930.258717660293, 5251.0, 5522.30971128609, 5689.914651280214, 5693.373728889839, 5747.511461525754, 5558.638688485255, 5575.972120139394, 5586.888262234753, 5587.664740115586, 5601.0, 5912.674802885839, 6347.270063942637, 6505.804825855208, 6511.0, 6517.120188774502, 5568.220449137124, 5628.212050312959, 5673.914891276634, 5798.507126894219, 5807.970960145214, 12499.812502812465, 12787.61637150887, 13076.280804555745, 13097.541586044443, 13208.801867971988, 2251.853629514076, 2348.998264944474, 2409.795167410772, 2449.64480150379, 2457.348802567321, 10153.238507111997, 10347.637832675895, 10483.161347092215, 10601.204909631808, 14457.349419276157, 1825.9452216433529, 1843.2442698493553, 1864.822841830024, 1870.186468886039, 1875.1749230338608, 78472.60763696203, 78810.21189788086, 79303.20696793016, 79911.0, 80332.57339412833, 9032.774180645405, 9795.755106122262, 9798.412095274307, 9850.950745246228, 10839.241253112365, 13108.868911310765, 13138.737225255632, 13262.801057984138, 13277.0, 13312.467501300032, 7459.216782237895, 7569.924300757032, 7703.845923081507, 7811.687532498637, 7819.569923654253, 7478.364339031244, 7531.623418829036, 7624.961875190588, 7719.305262526287, 7749.961250193825, 4079.326911059642, 4082.510098788105, 4117.485314335708, 4142.668586513072, 4198.6221240088535, 1974.6840505519049, 1983.652860749363, 2044.376465178135, 2049.333966460906, 2077.0994539996036, 944.5418971798672, 981.1316984468797, 981.3670182732097, 1073.5330131392868, 1089.9073578745895, 16801.327946882233, 18208.544786380447, 18588.0, 20012.89993550023, 20155.19379224844, 990.2226751999646, 999.6501224571488, 1039.3711804358406, 1074.6238816414193, 1088.3415533602215, 9288.256939444827, 10761.730956726144, 10837.512311945824, 10851.945740271249, 10897.019268265894, 445608.0, 451853.0, 472198.0, 474126.0, 474286.0, 59682.10476842851, 80745.0, 99765.50117249368, 99936.0, 102643.0, 1039.9740006499899, 1055.6305293147336, 1057.9365238085738, 1069.534752382716, 1072.0405237312561, 17206.741898871776, 17949.282028718706, 18018.36935707244, 18245.0, 18283.54291142732, 42794.0, 43072.78463607662, 43119.485569013756, 43928.56071439245, 44812.0, 51949.480505194464, 59343.0, 60791.0, 61328.0, 62440.37559624527, 8003.959980200062, 8607.741767746978, 8712.164748564608, 8785.604647790737, 8891.644334226818, 9565.473898935625, 12814.167079139826, 13164.078514503894, 13236.073474856668, 13250.933745331211, 11179.832302515306, 11408.258463199865, 11605.6518304451, 11874.821877672015, 12089.939550302191, 11397.772044558897, 11399.373034483184, 11434.256773309708, 11489.655310340702, 11494.54021839117, 11639.418029098342, 11826.526938922347, 11937.82093268619, 12018.579349722717, 12054.879451205376, 8143.226393492609, 8187.549684767157, 8345.768971626927, 8724.956375218084, 8787.780305492413, 8439.746807595537, 10470.633527826794, 11461.140414468782, 11751.647450576496, 11899.524019039141], "value": 8952.508203104644, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.1083349990008, 1531.7778922056298, 1670.3986564836657, 1812.7099664053753, 1816.4823025437752, 7993.120756716757, 8621.180987806165, 8686.913130868705, 9223.30825188111, 9233.49215793131, 8768.254698350633, 9066.320025998044, 9118.498482583454, 9139.817203655923, 9148.947870994838, 2415.311636183688, 2450.1669432392982, 2454.6563481112657, 2455.0, 2455.533448644752, 2400.807935365175, 2418.37122348189, 2449.7060352757694, 2455.545724041049, 2459.188467805629, 2375.8099352051795, 2390.5935990881503, 2403.555342261687, 2416.6979127609047, 2421.116292553223, 2359.2096647623066, 2387.8209134315, 2400.5558971590312, 2403.2910291463972, 2408.3015925381706, 2376.9524609507885, 2390.820688448356, 2413.8431001984814, 2420.9031638734427, 2422.9757702422926, 8955.776105597348, 9038.728838134866, 9047.366684332099, 9055.320850936141, 9069.54652267384, 5411.269478620376, 5536.252605898192, 5592.245046918654, 5596.412376700469, 5601.691906945116, 3311.8012919224925, 3436.4501679731375, 3533.770304930197, 3536.398812201906, 3550.9112272193142, 1206.3184300870068, 1231.7105480212142, 1235.3761350517932, 1262.482382223284, 1285.3380509037852, 12683.74632507354, 12776.999999999907, 12799.808002879965, 12803.743925121538, 12943.67640808978, 4701.78841952113, 4862.78117484714, 4948.752562371867, 4960.330355402047, 4970.8757281068265, 10779.461026948622, 10819.296745711503, 10819.459027048617, 10825.242233043611, 10840.72898177536, 5501.642393244426, 5508.55931525485, 5508.7521061552325, 5514.448555144534, 5529.640573362719, 4475.686701930834, 4851.927221091686, 5038.924416133761, 5049.267856160836, 5069.949300507022, 4098.262312783668, 4165.58344165581, 4169.3120635094865, 4185.066987956591, 4244.787760611957, 1316.7432350691522, 1348.5145347675025, 1354.823872896517, 1362.7514600908382, 1373.986260137386, 966.294604938399, 993.6025589764153, 995.8356871116184, 996.2030375699411, 1000.364768372089, 5902.734376952962, 5930.970345148333, 5957.374475680078, 6013.6993150342305, 6103.450689437972, 448.428253976183, 452.57005844447906, 453.71869440946165, 1056.8309070548676, 1095.906847917936, 4046.2109888571445, 4048.5748996355546, 4100.897477563085, 4157.584241575818, 4169.291220492523, 10962.506687199095, 11254.043406310555, 11277.830832537518, 11309.943450282695, 11322.26405283654, 10970.0, 11158.1631377647, 11163.832542511705, 11183.552657893755, 11192.664220073411, 8316.958415207764, 8355.0, 8437.451565648213, 8484.109168537214, 8518.87221691675, 5804.709764511842, 5875.265591801025, 5905.852353691021, 5992.221011268507, 6011.068284415923, 10144.137748291478, 10293.176545876462, 10511.474426278808, 10548.789024219319, 10550.841737373792, 10392.844107338547, 10485.842712359168, 10642.73393165177, 10760.139188864716, 10767.515461804081, 7726.729564465217, 7917.722879699183, 7978.401619878417, 7988.081370642218, 8163.387745919199, 8813.867791982997, 8828.382013259266, 8856.335774817044, 8864.42381245217, 8872.24585910205, 7874.921250787648, 8160.551169685724, 8184.672613095409, 8355.331573473986, 8372.455790373606, 7919.802004949923, 8044.758657240292, 8132.796680082809, 8214.301784348158, 8268.627911744106, 7054.294570542905, 7083.574985500886, 7182.4613154014705, 7221.350078492751, 7300.744473943387, 5195.882885179704, 5228.477152284741, 5382.3541175059245, 5391.8382448525035, 5475.616706830484, 5454.536364408911, 5473.972630136824, 5553.18027701266, 5640.971795140998, 5680.488756011979], "value": 4777.913106189347, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.9300553878147, 320.8973128598848, 325.234073756304, 326.186165517035, 329.05889157010944, 5578.219049333086, 5645.322561292651, 5648.576356773243, 5741.2536370271855, 5772.595918285721, 5568.331800183983, 5681.431856814316, 5701.57238207134, 5724.8855022899625, 5725.7995970141055, 4398.692091553593, 4408.823647054114, 4413.779311034452, 4420.31485119807, 4444.111177764444, 4166.437530933315, 4213.136307057046, 4274.615284624383, 4296.742195468266, 4322.178786030644, 4284.2930916398755, 4297.548757380477, 4342.544032876534, 4357.825686972533, 4374.278244089722, 4375.934360984587, 4383.605475507204, 4398.780060996969, 4399.780010999437, 4416.205083085043, 3805.6194380561724, 3805.8667946621736, 3846.8461261549505, 3847.384418493056, 3856.6529012388737, 5314.574834013309, 5363.597730170214, 5369.81205657804, 5422.295101636762, 5430.972845135789, 4943.752812359404, 4965.280034394992, 4999.32509111269, 5000.924986125175, 5013.699178049293, 5509.025126431722, 5852.385499522574, 5867.11993201019, 5871.148683440877, 5892.790203673622, 4219.620234178908, 4225.260579398593, 4233.978830105861, 4239.47006624172, 4243.236217480852, 5930.258717660336, 6055.818325450244, 6093.482054025369, 6145.955187618116, 6183.165272688175, 4347.891302717458, 4348.826046958149, 4359.716618419792, 4361.760103194291, 4361.847335343247, 4420.447444069491, 4421.756803375845, 4435.401220835211, 4437.29003359461, 4450.46594408673, 5030.597552195889, 5035.16919708244, 5052.57053150479, 5059.215821547666, 5066.6453348266, 5775.393583673654, 5860.648361098348, 5964.7315870785915, 5979.9402005980255, 6027.8794424111275, 1511.6749898771598, 1524.1769444499846, 1524.4511975688742, 1540.4762380790585, 1547.860692537677, 934.1825902335456, 979.9461029643295, 984.5963155106515, 988.1156365053237, 996.3872218585662, 5052.722100284446, 5072.199369223946, 5626.409227031185, 5719.456651618089, 5752.194692742935, 6087.482563982023, 6101.542384321194, 6142.600730952474, 6174.413430724164, 6179.0, 5541.224228607998, 5747.827565173052, 5844.824655260349, 5887.499562537147, 5919.141724449931, 3254.576905002382, 3276.836158192081, 3288.8293726140632, 3298.8185649789493, 3319.7344212462945, 6284.4344009039405, 6305.716242768995, 6329.449284925223, 6352.841178970562, 6455.644939528277, 5999.610025348338, 6141.788955975845, 6165.599236049642, 6237.313895471494, 6248.50011999039, 6332.208473940757, 6335.429811316912, 6359.759846829824, 6374.840628984312, 6392.4246817786625, 5930.8056019273145, 6056.57603967718, 6160.907586386118, 6180.969095154675, 6250.718717657625, 6074.757009719562, 6081.452669259788, 6110.755569777337, 6137.60105593135, 6149.292831324455, 6066.968615335315, 6321.683915804283, 6398.776042838478, 6401.327860574573, 6416.967915160394, 4233.555476674905, 4268.445102136827, 4280.571942805695, 4292.871213863589, 4297.72064815786, 6113.755449782137, 6130.969345153246, 6152.692365381802, 6160.843704703318, 6164.722587483664, 5841.386654401226, 5915.940840591711, 6005.699715014144, 6009.36901625323, 6016.315431679137, 5934.7922822701, 5942.64344139353, 5952.345242023461, 5959.851003724942, 5972.5520585955355, 5847.912281315698, 5851.502622276984, 5853.531717462678, 5868.332292317302, 5884.529237661062, 5776.624519406225, 5987.9401205989125, 6037.366076562073, 6042.667653279112, 6050.757969681164, 5907.438793314628, 5939.376365481735, 5940.930632486194, 5942.6731529766275, 5945.791897283574], "value": 4511.250117518845, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.7621772923794, 742.3059439424139, 757.2805834457267, 833.0752864320604, 860.9655613775449, 15017.39930402784, 15427.768583471243, 15669.921650391761, 15735.055896646196, 15745.763813542806, 14506.0, 14653.853461465382, 14737.852621473781, 14819.77770333446, 14856.55430337089, 666.3969107957306, 789.3211837819471, 791.5844181804556, 810.1493431896486, 812.3947658994058, 799.0451410564378, 801.819590592118, 805.8549461097, 806.4274365200714, 807.6163822184474, 854.4318028511063, 856.7943693513574, 857.237059017475, 860.956952152393, 862.3273846399787, 844.7465760271893, 848.0078308379211, 849.5964416901984, 854.0221446443818, 854.444611002847, 618.774147436187, 620.3362402229616, 622.747787146202, 623.0560700538688, 624.865653884417, 15388.53834384959, 15402.0, 15468.767968480483, 15501.534953951399, 15582.142982135978, 15175.241237938058, 15243.771343429857, 15410.0, 15464.768028479582, 15619.765703514457, 12651.557195498113, 12671.556495522613, 12741.17182383142, 12767.170133941265, 12800.551980680724, 3913.5695073541888, 3944.467496887912, 3970.583088775666, 4068.6948478863906, 4132.40080188371, 64020.0, 67283.3271667282, 67568.3243167567, 72786.90819637763, 82365.58817205875, 11457.966106744383, 11732.530698771954, 11795.646130616095, 11989.340586267665, 12286.385680715928, 21176.682349764767, 21306.78693213079, 21327.36017919465, 21370.679439808417, 21426.571468570542, 8945.910540894638, 8956.238719708768, 9048.321375896834, 9087.636494540277, 9275.814483710423, 4709.62323014158, 4713.6936099153445, 4770.260609605517, 4783.545563171493, 4828.855134345975, 3751.5498140222803, 3857.787821669835, 3868.2650296443585, 3872.0, 3883.7863917484246, 653.5523166630873, 669.7321071571313, 681.6762038031994, 682.607500687107, 690.9585424874524, 710.137183322266, 710.8827043537862, 712.7220384050224, 720.4164626652429, 722.9204787473374, 8595.441296315845, 8973.775655608662, 9004.36969412148, 9218.354715169873, 9293.95353023244, 655.7672026430644, 660.0429377402785, 666.2970566052861, 689.183317768446, 719.5790462579449, 4315.201687687788, 4398.3842262083335, 4492.438445194351, 4524.47968483622, 4565.977170114194, 66766.33233667698, 66980.33019669741, 109891.0, 112848.43575782068, 115434.422827887, 58523.0, 59016.0, 60389.69805150946, 99317.0, 100542.0, 54495.72752136214, 74504.62747686227, 88451.55774221088, 90882.54558727297, 91249.54375228082, 8849.557522123996, 8922.86615700778, 9104.681336153202, 9109.498977556297, 9155.908440915771, 40603.59396405998, 52489.0, 53785.46214537961, 53985.46014539804, 55519.444805553045, 75038.62480687561, 77637.61181194057, 79695.60152199202, 79725.0, 80189.1981080205, 10742.3017503862, 11044.392558409043, 11174.776504469703, 11214.383208923588, 11329.150313726339, 12343.567975120828, 12691.619251422471, 12938.159019664068, 13272.469101235842, 13316.0, 11620.883791162318, 11626.186166968231, 11884.702882428008, 11914.225575337576, 11966.521339146337, 11111.0, 11417.37204453763, 11564.537418503165, 11832.17174797756, 11993.640190793942, 11003.669889903316, 11372.20394572372, 11508.769824603629, 11539.249948753304, 11554.76890462203, 8932.821343573221, 8973.730788076367, 9010.774730631787, 9153.542322883963, 9249.352545322032, 8262.215089566482, 8676.826463470821, 8997.550122493718, 9195.448273103635, 9552.092551207625], "value": 7243.785114663715, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 111.0, 112.0, 111.0, 112.0, 109.0, 110.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 160.0, 175.0, 128.0, 161.0, 160.0, 134.0, 192.0, 127.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 162.0, 165.0, 168.0, 163.0, 164.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 179.0, 76.0, 75.0, 77.0, 75.0, 155.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 140.0, 86.0, 86.0, 86.0, 141.0, 85.0, 85.0, 149.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 117.0, 118.0, 119.0, 117.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 149.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 54.0, 53.0, 56.0, 61.0, 53.0, 52.0, 53.0, 52.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 83.0, 83.0, 82.0, 82.0, 81.0, 106.0, 80.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 131.0, 134.0, 124.0, 134.0, 123.0, 128.0, 133.0, 141.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 167.0, 157.0, 162.0, 163.0, 162.0, 161.0, 162.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 66.0, 65.0, 62.0, 62.0, 63.0, 63.0, 62.0], "value": 63.7, "unit": "score"}]}]} 20:43:08 INFO - Return code: 0 20:43:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:43:08 ERROR - # TBPL SUCCESS # 20:43:08 INFO - Running post-action listener: _resource_record_post_action 20:43:08 INFO - ##### 20:43:08 INFO - ##### Finished run-tests step (success) 20:43:08 INFO - ##### 20:43:08 INFO - Running post-run listener: _resource_record_post_run 20:43:08 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547082240; Read time: 16; Write time: 487744 20:43:08 INFO - TinderboxPrint: CPU usage
13.5% 20:43:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:43:08 INFO - TinderboxPrint: I/O write bytes / time
547,082,240 / 487,744 20:43:08 INFO - TinderboxPrint: CPU idle
8,215.2 (86.5%) 20:43:08 INFO - TinderboxPrint: CPU user
1,225.2 (12.9%) 20:43:08 INFO - TinderboxPrint: Swap in / out
0 / 0 20:43:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 255000576; Read time: 0; Write time: 237780 20:43:08 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291491840; Read time: 16; Write time: 249932 20:43:09 INFO - Running post-run listener: _upload_blobber_files 20:43:09 INFO - Blob upload gear active. 20:43:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:43:09 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 20:43:09 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:43:09 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:43:09 INFO - (blobuploader) - INFO - Open directory for files ... 20:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:43:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:43:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:43:14 INFO - (blobuploader) - INFO - Done attempting. 20:43:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:43:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:43:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:43:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:43:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:43:15 INFO - (blobuploader) - INFO - Done attempting. 20:43:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:43:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:43:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:43:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:43:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:43:16 INFO - (blobuploader) - INFO - Done attempting. 20:43:16 INFO - (blobuploader) - INFO - Iteration through files over. 20:43:16 INFO - Return code: 0 20:43:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:43:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:43:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55beca314a60c1b236ce3be760c6741307763c1a9a7b51fccc25518c5b2506691d2d3d0612bf9d6e8a21d79c6a92d7f44db6296dc8d4225e289a53e0dd9d1cb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28dbd27026ff33b587e995d2606a967c5a30815c7a91e235369a085f8d107e778169a3d38e20bb46c1bf5d713e345f3e8816d3cc763b59de21994b967b3acb1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78c3cc389212a391eb4faf65b960b3963c7ecefb1ca6f573490ce3dfff8cb758c2256cf1bf335ff7954339475648caa370320ccf7113a2cae4c70e31afec75a5"} 20:43:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:43:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:43:16 INFO - Contents: 20:43:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55beca314a60c1b236ce3be760c6741307763c1a9a7b51fccc25518c5b2506691d2d3d0612bf9d6e8a21d79c6a92d7f44db6296dc8d4225e289a53e0dd9d1cb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28dbd27026ff33b587e995d2606a967c5a30815c7a91e235369a085f8d107e778169a3d38e20bb46c1bf5d713e345f3e8816d3cc763b59de21994b967b3acb1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78c3cc389212a391eb4faf65b960b3963c7ecefb1ca6f573490ce3dfff8cb758c2256cf1bf335ff7954339475648caa370320ccf7113a2cae4c70e31afec75a5"} 20:43:16 INFO - Running post-run listener: copy_logs_to_upload_dir 20:43:16 INFO - Copying logs to upload dir... 20:43:16 INFO - mkdir: /builds/slave/test/build/upload/logs 20:43:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.326100 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-06 20:43:16.089797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 20:43:16.093108) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367 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/sha512/55beca314a60c1b236ce3be760c6741307763c1a9a7b51fccc25518c5b2506691d2d3d0612bf9d6e8a21d79c6a92d7f44db6296dc8d4225e289a53e0dd9d1cb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28dbd27026ff33b587e995d2606a967c5a30815c7a91e235369a085f8d107e778169a3d38e20bb46c1bf5d713e345f3e8816d3cc763b59de21994b967b3acb1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78c3cc389212a391eb4faf65b960b3963c7ecefb1ca6f573490ce3dfff8cb758c2256cf1bf335ff7954339475648caa370320ccf7113a2cae4c70e31afec75a5"} build_url:https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011527 build_url: 'https://queue.taskcluster.net/v1/task/a8tDyd1PQrqA0w1kRzaQvw/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/sha512/55beca314a60c1b236ce3be760c6741307763c1a9a7b51fccc25518c5b2506691d2d3d0612bf9d6e8a21d79c6a92d7f44db6296dc8d4225e289a53e0dd9d1cb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28dbd27026ff33b587e995d2606a967c5a30815c7a91e235369a085f8d107e778169a3d38e20bb46c1bf5d713e345f3e8816d3cc763b59de21994b967b3acb1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78c3cc389212a391eb4faf65b960b3963c7ecefb1ca6f573490ce3dfff8cb758c2256cf1bf335ff7954339475648caa370320ccf7113a2cae4c70e31afec75a5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 20:43:16.124565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 20:43:16.125343) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465268572.145828-910262367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.68 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 20:43:16.806207) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 20:43:16.806561) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 20:43:16.811653) ========= ========= Total master_lag: 0.78 =========