builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1465347411.56 results: success (0) buildid: 20160607170025 builduid: d338d83d93484fd49f4ced776397d117 revision: b93f2b53838a689fd175ad4b986f43feb4a2546c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:51.556116) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:51.556788) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:51.557283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:51.573778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:51.574259) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 17:56:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-06-07 17:56:52 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120516 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:51.710075) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:51.710870) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019658 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:51.763222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:51.763888) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b93f2b53838a689fd175ad4b986f43feb4a2546c --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 b93f2b53838a689fd175ad4b986f43feb4a2546c --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=5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 17:56:52,483 truncating revision to first 12 chars 2016-06-07 17:56:52,483 Setting DEBUG logging. 2016-06-07 17:56:52,483 attempt 1/10 2016-06-07 17:56:52,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b93f2b53838a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 17:56:52,891 unpacking tar archive at: fx-team-b93f2b53838a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.752534 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:52.532073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:52.532440) ========= script_repo_revision: b93f2b53838a689fd175ad4b986f43feb4a2546c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:52.532902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:52.533217) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 17:56:52.544745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 35 secs) (at 2016-06-07 17:56:52.545149) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:56:53 INFO - MultiFileLogger online at 20160607 17:56:53 in /builds/slave/test 17:56:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:56:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:56:53 INFO - {'append_to_log': False, 17:56:53 INFO - 'base_work_dir': '/builds/slave/test', 17:56:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:56:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:56:53 INFO - 'branch': 'Fx-Team-Non-PGO', 17:56:53 INFO - 'buildbot_json_path': 'buildprops.json', 17:56:53 INFO - 'config_files': ('talos/linux_config.py',), 17:56:53 INFO - 'default_actions': ('clobber', 17:56:53 INFO - 'read-buildbot-config', 17:56:53 INFO - 'download-and-extract', 17:56:53 INFO - 'populate-webroot', 17:56:53 INFO - 'create-virtualenv', 17:56:53 INFO - 'install', 17:56:53 INFO - 'run-tests'), 17:56:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:56:53 INFO - 'download_minidump_stackwalk': True, 17:56:53 INFO - 'download_symbols': 'ondemand', 17:56:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:56:53 INFO - 'tooltool.py': '/tools/tooltool.py', 17:56:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:56:53 INFO - '/tools/misc-python/virtualenv.py')}, 17:56:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:56:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:56:53 INFO - 'installer_path': 'installer.exe', 17:56:53 INFO - 'log_level': 'info', 17:56:53 INFO - 'log_name': 'talos', 17:56:53 INFO - 'log_to_console': True, 17:56:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:56:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:56:53 INFO - 'opt_config_files': (), 17:56:53 INFO - 'pip_index': False, 17:56:53 INFO - 'sps_profile': False, 17:56:53 INFO - 'sps_profile_interval': 0, 17:56:53 INFO - 'suite': 'dromaeojs-e10s', 17:56:53 INFO - 'system_bits': '32', 17:56:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:56:53 INFO - 'title': 'talos-linux64-ix-051', 17:56:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:56:53 INFO - 'use_talos_json': True, 17:56:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:56:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:56:53 INFO - 'work_dir': 'build'} 17:56:53 INFO - ##### 17:56:53 INFO - ##### Running clobber step. 17:56:53 INFO - ##### 17:56:53 INFO - Running pre-action listener: _resource_record_pre_action 17:56:53 INFO - Running main action method: clobber 17:56:53 INFO - rmtree: /builds/slave/test/build 17:56:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:56:54 INFO - Running post-action listener: _resource_record_post_action 17:56:54 INFO - ##### 17:56:54 INFO - ##### Finished clobber step (success) 17:56:54 INFO - ##### 17:56:54 INFO - ##### 17:56:54 INFO - ##### Running read-buildbot-config step. 17:56:54 INFO - ##### 17:56:54 INFO - Running pre-action listener: _resource_record_pre_action 17:56:54 INFO - Running main action method: read_buildbot_config 17:56:54 INFO - Using buildbot properties: 17:56:54 INFO - { 17:56:54 INFO - "project": "", 17:56:54 INFO - "product": "firefox", 17:56:54 INFO - "script_repo_revision": "production", 17:56:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:56:54 INFO - "repository": "", 17:56:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:56:54 INFO - "buildid": "20160607170025", 17:56:54 INFO - "pgo_build": "False", 17:56:54 INFO - "basedir": "/builds/slave/test", 17:56:54 INFO - "buildnumber": 1355, 17:56:54 INFO - "slavename": "talos-linux64-ix-051", 17:56:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:56:54 INFO - "platform": "ubuntu64_hw", 17:56:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:56:54 INFO - "branch": "fx-team", 17:56:54 INFO - "repo_path": "integration/fx-team", 17:56:54 INFO - "revision": "b93f2b53838a689fd175ad4b986f43feb4a2546c", 17:56:54 INFO - "stage_platform": "linux64", 17:56:54 INFO - "builduid": "d338d83d93484fd49f4ced776397d117", 17:56:54 INFO - "slavebuilddir": "test" 17:56:54 INFO - } 17:56:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:56:54 INFO - Running post-action listener: _resource_record_post_action 17:56:54 INFO - ##### 17:56:54 INFO - ##### Finished read-buildbot-config step (success) 17:56:54 INFO - ##### 17:56:54 INFO - ##### 17:56:54 INFO - ##### Running download-and-extract step. 17:56:54 INFO - ##### 17:56:54 INFO - Running pre-action listener: _resource_record_pre_action 17:56:54 INFO - Running main action method: download_and_extract 17:56:54 INFO - mkdir: /builds/slave/test/build/tests 17:56:54 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')]} 17:56:54 INFO - https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:56:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:56:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:56:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/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 17:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/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 17:56:54 INFO - Downloaded 1361 bytes. 17:56:54 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:56:54 INFO - Using the following test package requirements: 17:56:54 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:56:54 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:56:54 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:56:54 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:54 INFO - u'jsshell-linux-x86_64.zip'], 17:56:54 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:56:54 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:56:54 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:56:54 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:56:54 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:56:54 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:56:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:56:54 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:56:54 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')]} 17:56:54 INFO - https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:56:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:56:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:56:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/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 17:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/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 17:56:56 INFO - Downloaded 22873851 bytes. 17:56:56 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'] 17:56:56 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 17:56:57 INFO - Return code: 0 17:56:57 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 17:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:57 INFO - https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:56:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:56:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:56:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/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 17:56:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/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 17:56:58 INFO - Downloaded 22873851 bytes. 17:56:58 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'] 17:56:58 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 17:56:59 INFO - Return code: 0 17:56:59 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')]} 17:56:59 INFO - https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:56:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:56:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:56:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/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 17:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/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 17:57:01 INFO - Downloaded 10833369 bytes. 17:57:01 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'] 17:57:01 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 17:57:01 INFO - Return code: 0 17:57: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')]} 17:57:01 INFO - https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:57:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:57:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:57:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/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 17:57:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/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 17:57:03 INFO - Downloaded 55196669 bytes. 17:57:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:57:03 INFO - mkdir: /builds/slave/test/properties 17:57:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:57:03 INFO - Writing to file /builds/slave/test/properties/build_url 17:57:03 INFO - Contents: 17:57:03 INFO - build_url:https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:57:04 INFO - Running post-action listener: _resource_record_post_action 17:57:04 INFO - Running post-action listener: set_extra_try_arguments 17:57:04 INFO - ##### 17:57:04 INFO - ##### Finished download-and-extract step (success) 17:57:04 INFO - ##### 17:57:04 INFO - ##### 17:57:04 INFO - ##### Running populate-webroot step. 17:57:04 INFO - ##### 17:57:04 INFO - Running pre-action listener: _resource_record_pre_action 17:57:04 INFO - Running main action method: populate_webroot 17:57:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:57:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:57:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:57:04 INFO - '--tppagecycles', 17:57:04 INFO - '7'], 17:57:04 INFO - 'tests': ['tsvgm']}}, 17:57:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:57:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:57:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:57:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:57:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:57:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:57:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:04 INFO - 'talos_options': ['--disable-e10s'], 17:57:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:04 INFO - 'talos_options': ['--disable-e10s'], 17:57:04 INFO - 'tests': ['damp', 'tps']}, 17:57:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:04 INFO - 'tests': ['damp', 'tps']}, 17:57:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:57:04 INFO - 'tests': ['dromaeo_dom']}, 17:57:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:57:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:57:04 INFO - 'tests': ['a11yr', 17:57:04 INFO - 'ts_paint', 17:57:04 INFO - 'tpaint', 17:57:04 INFO - 'sessionrestore', 17:57:04 INFO - 'sessionrestore_no_auto_restore', 17:57:04 INFO - 'tabpaint']}, 17:57:04 INFO - 'other-e10s': {'tests': ['a11yr', 17:57:04 INFO - 'ts_paint', 17:57:04 INFO - 'tpaint', 17:57:04 INFO - 'sessionrestore', 17:57:04 INFO - 'sessionrestore_no_auto_restore', 17:57:04 INFO - 'tabpaint']}, 17:57:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:57:04 INFO - 'ts_paint', 17:57:04 INFO - 'tpaint', 17:57:04 INFO - 'sessionrestore', 17:57:04 INFO - 'sessionrestore_no_auto_restore', 17:57:04 INFO - 'tabpaint']}, 17:57:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:57:04 INFO - 'ts_paint', 17:57:04 INFO - 'tpaint', 17:57:04 INFO - 'sessionrestore', 17:57:04 INFO - 'sessionrestore_no_auto_restore', 17:57:04 INFO - 'tabpaint']}, 17:57:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:57:04 INFO - 'tests': ['a11yr', 17:57:04 INFO - 'ts_paint', 17:57:04 INFO - 'tpaint', 17:57:04 INFO - 'sessionrestore', 17:57:04 INFO - 'sessionrestore_no_auto_restore', 17:57:04 INFO - 'tabpaint']}, 17:57:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:57:04 INFO - 'tests': ['a11yr', 17:57:04 INFO - 'ts_paint', 17:57:04 INFO - 'tpaint', 17:57:04 INFO - 'sessionrestore', 17:57:04 INFO - 'sessionrestore_no_auto_restore', 17:57:04 INFO - 'tabpaint']}, 17:57:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:57:04 INFO - 'tests': ['tsvgx', 17:57:04 INFO - 'tsvgr_opacity', 17:57:04 INFO - 'tart', 17:57:04 INFO - 'tscrollx', 17:57:04 INFO - 'cart']}, 17:57:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:57:04 INFO - 'tsvgr_opacity', 17:57:04 INFO - 'tart', 17:57:04 INFO - 'tscrollx', 17:57:04 INFO - 'cart']}, 17:57:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:04 INFO - 'talos_options': ['--disable-e10s'], 17:57:04 INFO - 'tests': ['tp5o']}, 17:57:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:04 INFO - 'tests': ['tp5o']}, 17:57:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:04 INFO - 'talos_options': ['--disable-e10s', 17:57:04 INFO - '--xperf_path', 17:57:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:04 INFO - 'tests': ['tp5n']}, 17:57:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:04 INFO - 'talos_options': ['--xperf_path', 17:57:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:04 INFO - 'tests': ['tp5n']}}, 17:57:04 INFO - 'talos.zip': {'path': '', 17:57:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:57:04 INFO - Running post-action listener: _resource_record_post_action 17:57:04 INFO - ##### 17:57:04 INFO - ##### Finished populate-webroot step (success) 17:57:04 INFO - ##### 17:57:04 INFO - ##### 17:57:04 INFO - ##### Running create-virtualenv step. 17:57:04 INFO - ##### 17:57:04 INFO - Running pre-action listener: _resource_record_pre_action 17:57:04 INFO - Running main action method: create_virtualenv 17:57:04 INFO - Creating virtualenv /builds/slave/test/build/venv 17:57:04 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 17:57:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:57:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:57:04 INFO - Using real prefix '/usr' 17:57:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:57:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:57:06 INFO - Installing pip.................done. 17:57:06 INFO - Return code: 0 17:57:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:57:06 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')]} 17:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:06 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')]} 17:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:06 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 0x7f9b054a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c1c0>, '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 0x290d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', '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 17:57:06 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 17:57:06 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 17:57:06 INFO - Using env: {'DISPLAY': ':0', 17:57:06 INFO - 'HOME': '/home/cltbld', 17:57:06 INFO - 'LANG': 'en_US.UTF-8', 17:57:06 INFO - 'LANGUAGE': 'en_US:en', 17:57:06 INFO - 'LOGNAME': 'cltbld', 17:57:06 INFO - 'MAIL': '/var/mail/cltbld', 17:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:06 INFO - 'MOZ_NO_REMOTE': '1', 17:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:06 INFO - 'NO_EM_RESTART': '1', 17:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:06 INFO - 'PWD': '/builds/slave/test', 17:57:06 INFO - 'SHELL': '/bin/bash', 17:57:06 INFO - 'SHLVL': '1', 17:57:06 INFO - 'TERM': 'linux', 17:57:06 INFO - 'TMOUT': '86400', 17:57:06 INFO - 'USER': 'cltbld', 17:57:06 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', 17:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:06 INFO - '_': '/tools/buildbot/bin/python'} 17:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:06 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 17:57:06 INFO - Cleaning up... 17:57:07 INFO - Return code: 0 17:57:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:57: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')]} 17:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57: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')]} 17:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:07 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 0x7f9b054a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c1c0>, '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 0x290d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', '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 17:57:07 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 17:57:07 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 17:57:07 INFO - Using env: {'DISPLAY': ':0', 17:57:07 INFO - 'HOME': '/home/cltbld', 17:57:07 INFO - 'LANG': 'en_US.UTF-8', 17:57:07 INFO - 'LANGUAGE': 'en_US:en', 17:57:07 INFO - 'LOGNAME': 'cltbld', 17:57:07 INFO - 'MAIL': '/var/mail/cltbld', 17:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:07 INFO - 'MOZ_NO_REMOTE': '1', 17:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:07 INFO - 'NO_EM_RESTART': '1', 17:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:07 INFO - 'PWD': '/builds/slave/test', 17:57:07 INFO - 'SHELL': '/bin/bash', 17:57:07 INFO - 'SHLVL': '1', 17:57:07 INFO - 'TERM': 'linux', 17:57:07 INFO - 'TMOUT': '86400', 17:57:07 INFO - 'USER': 'cltbld', 17:57:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', 17:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:07 INFO - '_': '/tools/buildbot/bin/python'} 17:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:07 INFO - Downloading/unpacking psutil>=3.1.1 17:57:07 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 17:57:07 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 17:57:07 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 17:57:07 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 17:57:07 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 17:57:07 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 17:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:57:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:57:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:57:09 INFO - Installing collected packages: psutil 17:57:09 INFO - Running setup.py install for psutil 17:57:09 INFO - building 'psutil._psutil_linux' extension 17:57:09 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 17:57:09 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 17:57:09 INFO - building 'psutil._psutil_posix' extension 17:57:09 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 17:57:09 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 17:57:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:57:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:57:09 INFO - Successfully installed psutil 17:57:09 INFO - Cleaning up... 17:57:09 INFO - Return code: 0 17:57:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:57:09 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')]} 17:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:09 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')]} 17:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:09 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 0x7f9b054a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c1c0>, '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 0x290d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', '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 17:57:09 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 17:57:09 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 17:57:09 INFO - Using env: {'DISPLAY': ':0', 17:57:09 INFO - 'HOME': '/home/cltbld', 17:57:09 INFO - 'LANG': 'en_US.UTF-8', 17:57:09 INFO - 'LANGUAGE': 'en_US:en', 17:57:09 INFO - 'LOGNAME': 'cltbld', 17:57:09 INFO - 'MAIL': '/var/mail/cltbld', 17:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:09 INFO - 'MOZ_NO_REMOTE': '1', 17:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:09 INFO - 'NO_EM_RESTART': '1', 17:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:09 INFO - 'PWD': '/builds/slave/test', 17:57:09 INFO - 'SHELL': '/bin/bash', 17:57:09 INFO - 'SHLVL': '1', 17:57:09 INFO - 'TERM': 'linux', 17:57:09 INFO - 'TMOUT': '86400', 17:57:09 INFO - 'USER': 'cltbld', 17:57:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', 17:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:09 INFO - '_': '/tools/buildbot/bin/python'} 17:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:57:11 INFO - Installing collected packages: mozsystemmonitor 17:57:11 INFO - Running setup.py install for mozsystemmonitor 17:57:12 INFO - Successfully installed mozsystemmonitor 17:57:12 INFO - Cleaning up... 17:57:12 INFO - Return code: 0 17:57:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:57:12 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')]} 17:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:12 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')]} 17:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:12 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 0x7f9b054a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c1c0>, '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 0x290d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', '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 17:57:12 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 17:57:12 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 17:57:12 INFO - Using env: {'DISPLAY': ':0', 17:57:12 INFO - 'HOME': '/home/cltbld', 17:57:12 INFO - 'LANG': 'en_US.UTF-8', 17:57:12 INFO - 'LANGUAGE': 'en_US:en', 17:57:12 INFO - 'LOGNAME': 'cltbld', 17:57:12 INFO - 'MAIL': '/var/mail/cltbld', 17:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:12 INFO - 'MOZ_NO_REMOTE': '1', 17:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:12 INFO - 'NO_EM_RESTART': '1', 17:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:12 INFO - 'PWD': '/builds/slave/test', 17:57:12 INFO - 'SHELL': '/bin/bash', 17:57:12 INFO - 'SHLVL': '1', 17:57:12 INFO - 'TERM': 'linux', 17:57:12 INFO - 'TMOUT': '86400', 17:57:12 INFO - 'USER': 'cltbld', 17:57:12 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', 17:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:12 INFO - '_': '/tools/buildbot/bin/python'} 17:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:12 INFO - Downloading/unpacking jsonschema==2.5.1 17:57: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 17:57: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 17:57: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 17:57: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 17:57: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 17:57: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 17:57:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:57:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:57:14 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 17:57:14 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 17:57:14 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 17:57:14 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 17:57:14 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 17:57:14 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 17:57:14 INFO - Downloading functools32-3.2.3-2.tar.gz 17:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:57:14 INFO - warning: no files found matching '*.txt' 17:57:14 INFO - no previously-included directories found matching 'build' 17:57:14 INFO - no previously-included directories found matching 'dist' 17:57:14 INFO - no previously-included directories found matching '.git*' 17:57:14 INFO - Installing collected packages: jsonschema, functools32 17:57:14 INFO - Running setup.py install for functools32 17:57:14 INFO - warning: no files found matching '*.txt' 17:57:14 INFO - no previously-included directories found matching 'build' 17:57:14 INFO - no previously-included directories found matching 'dist' 17:57:14 INFO - no previously-included directories found matching '.git*' 17:57:14 INFO - Successfully installed jsonschema functools32 17:57:14 INFO - Cleaning up... 17:57:14 INFO - Return code: 0 17:57:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:57: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')]} 17:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57: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')]} 17:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57: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', '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 0x7f9b054a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c1c0>, '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 0x290d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', '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 17:57: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:57: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 blobuploader==1.2.4 17:57:14 INFO - Using env: {'DISPLAY': ':0', 17:57:14 INFO - 'HOME': '/home/cltbld', 17:57:14 INFO - 'LANG': 'en_US.UTF-8', 17:57:14 INFO - 'LANGUAGE': 'en_US:en', 17:57:14 INFO - 'LOGNAME': 'cltbld', 17:57:14 INFO - 'MAIL': '/var/mail/cltbld', 17:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:14 INFO - 'MOZ_NO_REMOTE': '1', 17:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:14 INFO - 'NO_EM_RESTART': '1', 17:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:14 INFO - 'PWD': '/builds/slave/test', 17:57:14 INFO - 'SHELL': '/bin/bash', 17:57:14 INFO - 'SHLVL': '1', 17:57:14 INFO - 'TERM': 'linux', 17:57:14 INFO - 'TMOUT': '86400', 17:57:14 INFO - 'USER': 'cltbld', 17:57:14 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', 17:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:14 INFO - '_': '/tools/buildbot/bin/python'} 17:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:14 INFO - Downloading/unpacking blobuploader==1.2.4 17:57:14 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 17:57:14 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 17:57:14 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 17:57:14 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 17:57:14 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 17:57:14 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 17:57:16 INFO - Downloading blobuploader-1.2.4.tar.gz 17:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:57:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:57: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 17:57: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 17:57: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 17:57: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 17:57: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 17:57: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 17:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:57:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:57: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 17:57: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 17:57: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 17:57: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 17:57: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 17:57: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 17:57:17 INFO - Downloading docopt-0.6.1.tar.gz 17:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:57:17 INFO - Installing collected packages: blobuploader, requests, docopt 17:57:17 INFO - Running setup.py install for blobuploader 17:57:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:57:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:57:17 INFO - Running setup.py install for requests 17:57:17 INFO - Running setup.py install for docopt 17:57:18 INFO - Successfully installed blobuploader requests docopt 17:57:18 INFO - Cleaning up... 17:57:18 INFO - Return code: 0 17:57:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:18 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')]} 17:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:18 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')]} 17:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:18 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 0x7f9b054a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c1c0>, '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 0x290d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', '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 17:57:18 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 17:57:18 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 17:57:18 INFO - Using env: {'DISPLAY': ':0', 17:57:18 INFO - 'HOME': '/home/cltbld', 17:57:18 INFO - 'LANG': 'en_US.UTF-8', 17:57:18 INFO - 'LANGUAGE': 'en_US:en', 17:57:18 INFO - 'LOGNAME': 'cltbld', 17:57:18 INFO - 'MAIL': '/var/mail/cltbld', 17:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:18 INFO - 'MOZ_NO_REMOTE': '1', 17:57:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:18 INFO - 'NO_EM_RESTART': '1', 17:57:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:18 INFO - 'PWD': '/builds/slave/test', 17:57:18 INFO - 'SHELL': '/bin/bash', 17:57:18 INFO - 'SHLVL': '1', 17:57:18 INFO - 'TERM': 'linux', 17:57:18 INFO - 'TMOUT': '86400', 17:57:18 INFO - 'USER': 'cltbld', 17:57:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', 17:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:18 INFO - '_': '/tools/buildbot/bin/python'} 17:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:18 INFO - Running setup.py (path:/tmp/pip-CB9J4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:18 INFO - Running setup.py (path:/tmp/pip-oVm7N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:18 INFO - Running setup.py (path:/tmp/pip-A0wdNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:18 INFO - Running setup.py (path:/tmp/pip-6gkMYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:18 INFO - Running setup.py (path:/tmp/pip-bVr_tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:18 INFO - Running setup.py (path:/tmp/pip-_SlqTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:18 INFO - Running setup.py (path:/tmp/pip-o7UONc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:18 INFO - Running setup.py (path:/tmp/pip-_MlIXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:18 INFO - Running setup.py (path:/tmp/pip-cjeeN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:18 INFO - Running setup.py (path:/tmp/pip-qvri9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:19 INFO - Running setup.py (path:/tmp/pip-qjiS_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:19 INFO - Running setup.py (path:/tmp/pip-Vx7AgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:19 INFO - Running setup.py (path:/tmp/pip-dLKG0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:19 INFO - Running setup.py (path:/tmp/pip-2bfOTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:19 INFO - Running setup.py (path:/tmp/pip-RVeBpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:19 INFO - Running setup.py (path:/tmp/pip-SecDDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:19 INFO - Running setup.py (path:/tmp/pip-nttQX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:57:19 INFO - Running setup.py install for manifestparser 17:57:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:57:19 INFO - Running setup.py install for mozcrash 17:57:19 INFO - Running setup.py install for mozdebug 17:57:19 INFO - Running setup.py install for mozdevice 17:57:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:57:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:57:19 INFO - Running setup.py install for mozfile 17:57:20 INFO - Running setup.py install for mozhttpd 17:57:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Running setup.py install for mozinfo 17:57:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Running setup.py install for mozInstall 17:57:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Running setup.py install for mozleak 17:57:20 INFO - Running setup.py install for mozlog 17:57:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Running setup.py install for moznetwork 17:57:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Running setup.py install for mozprocess 17:57:20 INFO - Running setup.py install for mozprofile 17:57:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Running setup.py install for mozrunner 17:57:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:57:21 INFO - Running setup.py install for mozscreenshot 17:57:21 INFO - Running setup.py install for moztest 17:57:21 INFO - Running setup.py install for mozversion 17:57:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:57:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:57:21 INFO - Cleaning up... 17:57:21 INFO - Return code: 0 17:57:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:21 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 0x7f9b054a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c1c0>, '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 0x290d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', '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 17:57:21 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 17:57:21 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 17:57:21 INFO - Using env: {'DISPLAY': ':0', 17:57:21 INFO - 'HOME': '/home/cltbld', 17:57:21 INFO - 'LANG': 'en_US.UTF-8', 17:57:21 INFO - 'LANGUAGE': 'en_US:en', 17:57:21 INFO - 'LOGNAME': 'cltbld', 17:57:21 INFO - 'MAIL': '/var/mail/cltbld', 17:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:21 INFO - 'MOZ_NO_REMOTE': '1', 17:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:21 INFO - 'NO_EM_RESTART': '1', 17:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:21 INFO - 'PWD': '/builds/slave/test', 17:57:21 INFO - 'SHELL': '/bin/bash', 17:57:21 INFO - 'SHLVL': '1', 17:57:21 INFO - 'TERM': 'linux', 17:57:21 INFO - 'TMOUT': '86400', 17:57:21 INFO - 'USER': 'cltbld', 17:57:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', 17:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:21 INFO - '_': '/tools/buildbot/bin/python'} 17:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:21 INFO - Running setup.py (path:/tmp/pip-HRem7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:21 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)) 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:21 INFO - Running setup.py (path:/tmp/pip-wRcSdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:21 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)) 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:21 INFO - Running setup.py (path:/tmp/pip-1qllHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:21 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)) 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:21 INFO - Running setup.py (path:/tmp/pip-g_6JE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:21 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)) 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:21 INFO - Running setup.py (path:/tmp/pip-Hp05ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:21 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)) 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:21 INFO - Running setup.py (path:/tmp/pip-rZyZPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:21 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)) 17:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:21 INFO - Running setup.py (path:/tmp/pip-ipGbef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:22 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)) 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:22 INFO - Running setup.py (path:/tmp/pip-srlWZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:22 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)) 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:22 INFO - Running setup.py (path:/tmp/pip-8cQDj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:22 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)) 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:22 INFO - Running setup.py (path:/tmp/pip-tIttgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:22 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)) 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:22 INFO - Running setup.py (path:/tmp/pip-YUMbpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:22 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)) 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:22 INFO - Running setup.py (path:/tmp/pip-Mz_Nqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:22 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)) 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:22 INFO - Running setup.py (path:/tmp/pip-SSdmPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:22 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)) 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:22 INFO - Running setup.py (path:/tmp/pip-RSzRuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:22 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)) 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:22 INFO - Running setup.py (path:/tmp/pip-4hD_n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:22 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)) 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:22 INFO - Running setup.py (path:/tmp/pip-1punJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:22 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)) 17:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:22 INFO - Running setup.py (path:/tmp/pip-DLs62k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:22 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)) 17:57:22 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)) 17:57:22 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)) 17:57:22 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)) 17:57:22 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)) 17:57:22 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)) 17:57:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:57:22 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 17:57:22 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 17:57:22 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 17:57:22 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 17:57:22 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 17:57:22 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 17:57:24 INFO - Downloading blessings-1.6.tar.gz 17:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:57:24 INFO - Installing collected packages: blessings 17:57:24 INFO - Running setup.py install for blessings 17:57:24 INFO - Successfully installed blessings 17:57:24 INFO - Cleaning up... 17:57:24 INFO - Return code: 0 17:57:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:57:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:25 INFO - Reading from file tmpfile_stdout 17:57:25 INFO - Current package versions: 17:57:25 INFO - argparse == 1.2.1 17:57:25 INFO - blessings == 1.6 17:57:25 INFO - blobuploader == 1.2.4 17:57:25 INFO - docopt == 0.6.1 17:57:25 INFO - functools32 == 3.2.3-2 17:57:25 INFO - jsonschema == 2.5.1 17:57:25 INFO - manifestparser == 1.1 17:57:25 INFO - mozInstall == 1.12 17:57:25 INFO - mozcrash == 0.17 17:57:25 INFO - mozdebug == 0.1 17:57:25 INFO - mozdevice == 0.48 17:57:25 INFO - mozfile == 1.2 17:57:25 INFO - mozhttpd == 0.7 17:57:25 INFO - mozinfo == 0.9 17:57:25 INFO - mozleak == 0.1 17:57:25 INFO - mozlog == 3.2 17:57:25 INFO - moznetwork == 0.27 17:57:25 INFO - mozprocess == 0.22 17:57:25 INFO - mozprofile == 0.28 17:57:25 INFO - mozrunner == 6.11 17:57:25 INFO - mozscreenshot == 0.1 17:57:25 INFO - mozsystemmonitor == 0.3 17:57:25 INFO - moztest == 0.7 17:57:25 INFO - mozversion == 1.4 17:57:25 INFO - psutil == 3.1.1 17:57:25 INFO - requests == 1.2.3 17:57:25 INFO - wsgiref == 0.1.2 17:57:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:25 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')]} 17:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:25 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')]} 17:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:25 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 0x7f9b054a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c1c0>, '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 0x290d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', '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 17:57:25 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 17:57:25 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 17:57:25 INFO - Using env: {'DISPLAY': ':0', 17:57:25 INFO - 'HOME': '/home/cltbld', 17:57:25 INFO - 'LANG': 'en_US.UTF-8', 17:57:25 INFO - 'LANGUAGE': 'en_US:en', 17:57:25 INFO - 'LOGNAME': 'cltbld', 17:57:25 INFO - 'MAIL': '/var/mail/cltbld', 17:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:25 INFO - 'MOZ_NO_REMOTE': '1', 17:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:25 INFO - 'NO_EM_RESTART': '1', 17:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:25 INFO - 'PWD': '/builds/slave/test', 17:57:25 INFO - 'SHELL': '/bin/bash', 17:57:25 INFO - 'SHLVL': '1', 17:57:25 INFO - 'TERM': 'linux', 17:57:25 INFO - 'TMOUT': '86400', 17:57:25 INFO - 'USER': 'cltbld', 17:57:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', 17:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:25 INFO - '_': '/tools/buildbot/bin/python'} 17:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 INFO - Cleaning up... 17:57:25 INFO - Return code: 0 17:57:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:57:25 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')]} 17:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:25 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')]} 17:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:25 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 0x7f9b054a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c1c0>, '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 0x290d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', '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 17:57:25 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 17:57:25 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 17:57:25 INFO - Using env: {'DISPLAY': ':0', 17:57:25 INFO - 'HOME': '/home/cltbld', 17:57:25 INFO - 'LANG': 'en_US.UTF-8', 17:57:25 INFO - 'LANGUAGE': 'en_US:en', 17:57:25 INFO - 'LOGNAME': 'cltbld', 17:57:25 INFO - 'MAIL': '/var/mail/cltbld', 17:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:25 INFO - 'MOZ_NO_REMOTE': '1', 17:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:25 INFO - 'NO_EM_RESTART': '1', 17:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:25 INFO - 'PWD': '/builds/slave/test', 17:57:25 INFO - 'SHELL': '/bin/bash', 17:57:25 INFO - 'SHLVL': '1', 17:57:25 INFO - 'TERM': 'linux', 17:57:25 INFO - 'TMOUT': '86400', 17:57:25 INFO - 'USER': 'cltbld', 17:57:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', 17:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:25 INFO - '_': '/tools/buildbot/bin/python'} 17:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:57:25 INFO - Cleaning up... 17:57:25 INFO - Return code: 0 17:57:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:57:25 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')]} 17:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:25 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')]} 17:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:25 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 0x7f9b054a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c1c0>, '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 0x290d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', '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 17:57:25 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 17:57:25 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 17:57:25 INFO - Using env: {'DISPLAY': ':0', 17:57:25 INFO - 'HOME': '/home/cltbld', 17:57:25 INFO - 'LANG': 'en_US.UTF-8', 17:57:25 INFO - 'LANGUAGE': 'en_US:en', 17:57:25 INFO - 'LOGNAME': 'cltbld', 17:57:25 INFO - 'MAIL': '/var/mail/cltbld', 17:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:25 INFO - 'MOZ_NO_REMOTE': '1', 17:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:25 INFO - 'NO_EM_RESTART': '1', 17:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:25 INFO - 'PWD': '/builds/slave/test', 17:57:25 INFO - 'SHELL': '/bin/bash', 17:57:25 INFO - 'SHLVL': '1', 17:57:25 INFO - 'TERM': 'linux', 17:57:25 INFO - 'TMOUT': '86400', 17:57:25 INFO - 'USER': 'cltbld', 17:57:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', 17:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:25 INFO - '_': '/tools/buildbot/bin/python'} 17:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:25 INFO - Downloading/unpacking flake8 17:57:25 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 17:57:25 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 17:57:25 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 17:57:25 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 17:57:25 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 17:57:25 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 17:57:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:57:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:57:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:57:28 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 17:57:28 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 17:57:28 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 17:57:28 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 17:57:28 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 17:57:28 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 17:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:57:28 INFO - no previously-included directories found matching 'docs/_build' 17:57:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:57:28 INFO - Running setup.py install for pep8 17:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:57:28 INFO - no previously-included directories found matching 'docs/_build' 17:57:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:57:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:57:28 INFO - Cleaning up... 17:57:28 INFO - Return code: 0 17:57:28 INFO - Running post-action listener: _resource_record_post_action 17:57:28 INFO - Running post-action listener: _start_resource_monitoring 17:57:28 INFO - Starting resource monitoring. 17:57:28 INFO - ##### 17:57:28 INFO - ##### Finished create-virtualenv step (success) 17:57:28 INFO - ##### 17:57:28 INFO - ##### 17:57:28 INFO - ##### Running install step. 17:57:28 INFO - ##### 17:57:28 INFO - Running pre-action listener: _resource_record_pre_action 17:57:28 INFO - Running main action method: install 17:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:28 INFO - Reading from file tmpfile_stdout 17:57:28 INFO - Detecting whether we're running mozinstall >=1.0... 17:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:57:28 INFO - Reading from file tmpfile_stdout 17:57:28 INFO - Output received: 17:57:28 INFO - Usage: mozinstall [options] installer 17:57:28 INFO - Options: 17:57:28 INFO - -h, --help show this help message and exit 17:57:28 INFO - -d DEST, --destination=DEST 17:57:28 INFO - Directory to install application into. [default: 17:57:28 INFO - "/builds/slave/test"] 17:57:28 INFO - --app=APP Application being installed. [default: firefox] 17:57:28 INFO - mkdir: /builds/slave/test/build/application 17:57:28 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'] 17:57:28 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 17:57:44 INFO - Reading from file tmpfile_stdout 17:57:44 INFO - Output received: 17:57:44 INFO - /builds/slave/test/build/application/firefox/firefox 17:57:44 INFO - Running post-action listener: _resource_record_post_action 17:57:44 INFO - ##### 17:57:44 INFO - ##### Finished install step (success) 17:57:44 INFO - ##### 17:57:44 INFO - ##### 17:57:44 INFO - ##### Running run-tests step. 17:57:44 INFO - ##### 17:57:44 INFO - Running pre-action listener: _resource_record_pre_action 17:57:44 INFO - Running main action method: run_tests 17:57:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:57:44 INFO - Python 2.7.3 17:57:44 INFO - Return code: 0 17:57:44 INFO - grabbing minidump binary from tooltool 17:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:57:44 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 0x290c1c0>, '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 0x290d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:57:44 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 17:57:44 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 17:57:44 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 17:57:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:57:44 INFO - Return code: 0 17:57:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:57:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:57:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:57:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:57:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:57:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:57:45 INFO - Return code: 0 17:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 17:57:45 INFO - Using env: {'DISPLAY': ':0', 17:57:45 INFO - 'HOME': '/home/cltbld', 17:57:45 INFO - 'LANG': 'en_US.UTF-8', 17:57:45 INFO - 'LANGUAGE': 'en_US:en', 17:57:45 INFO - 'LOGNAME': 'cltbld', 17:57:45 INFO - 'MAIL': '/var/mail/cltbld', 17:57:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:57:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:45 INFO - 'MOZ_NO_REMOTE': '1', 17:57:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:45 INFO - 'NO_EM_RESTART': '1', 17:57:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:45 INFO - 'PWD': '/builds/slave/test', 17:57:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:57:45 INFO - 'SHELL': '/bin/bash', 17:57:45 INFO - 'SHLVL': '1', 17:57:45 INFO - 'TERM': 'linux', 17:57:45 INFO - 'TMOUT': '86400', 17:57:45 INFO - 'USER': 'cltbld', 17:57:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882', 17:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:45 INFO - '_': '/tools/buildbot/bin/python'} 17:57:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:57:46 INFO - mozversion application_buildid: 20160607170025 17:57:46 INFO - mozversion application_changeset: b93f2b53838a689fd175ad4b986f43feb4a2546c 17:57:46 INFO - mozversion application_display_name: Nightly 17:57:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:57:46 INFO - mozversion application_name: Firefox 17:57:46 INFO - mozversion application_remotingname: firefox 17:57:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:57:46 INFO - mozversion application_vendor: Mozilla 17:57:46 INFO - mozversion application_version: 50.0a1 17:57:46 INFO - mozversion platform_buildid: 20160607170025 17:57:46 INFO - mozversion platform_changeset: b93f2b53838a689fd175ad4b986f43feb4a2546c 17:57:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:57:46 INFO - mozversion platform_version: 50.0a1 17:57:46 INFO - using testdate: 1465347466 17:57:46 INFO - actual date: 1465347466 17:57:46 INFO - starting webserver on 'localhost:40893' 17:57:46 INFO - SUITE-START | Running 2 tests 17:57:46 INFO - TEST-START | dromaeo_css 17:57:46 INFO - operating with platform_type : linux_ 17:57:46 INFO - Initialising browser for dromaeo_css test... 17:57:46 INFO - TEST-INFO | started process 1148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXx2azf/profile http://localhost:40893/getInfo.html) 17:57:50 INFO - PROCESS | 1148 | __metrics Screen width/height:1600/1200 17:57:50 INFO - PROCESS | 1148 | colorDepth:24 17:57:50 INFO - PROCESS | 1148 | Browser inner width/height: 1024/697 17:57:50 INFO - PROCESS | 1148 | __metrics 17:57:51 ERROR - PROCESS | 1148 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 17:57:52 INFO - TEST-INFO | 1148: exit 0 17:57:52 INFO - Browser initialized. 17:57:52 INFO - Running cycle 1/1 for dromaeo_css test... 17:57:52 INFO - TEST-INFO | started process 1334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXx2azf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:04 INFO - PROCESS | 1334 | RSS: Main: 167821312 17:58:04 INFO - PROCESS | 1334 | 17:58:54 INFO - PROCESS | 1334 | 1465347534025 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] 18:01:05 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:40893/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40893/tests/dromaeo/cssquery-ext.html) 18:01:06 INFO - PROCESS | 1334 | RSS: Main: 170860544 18:01:06 INFO - PROCESS | 1334 | 18:04:08 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:40893/tests/dromaeo/cssquery-ext.html (next: http://localhost:40893/tests/dromaeo/cssquery-jquery.html) 18:04:09 INFO - PROCESS | 1334 | RSS: Main: 170078208 18:04:09 INFO - PROCESS | 1334 | 18:07:11 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:40893/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40893/tests/dromaeo/cssquery-mootools.html) 18:07:12 INFO - PROCESS | 1334 | RSS: Main: 171229184 18:07:12 INFO - PROCESS | 1334 | 18:10:13 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:40893/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40893/tests/dromaeo/cssquery-prototype.html) 18:10:14 INFO - PROCESS | 1334 | RSS: Main: 168480768 18:10:14 INFO - PROCESS | 1334 | 18:13:17 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:40893/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40893/tests/dromaeo/cssquery-yui.html) 18:13:17 INFO - PROCESS | 1334 | RSS: Main: 170676224 18:13:17 INFO - PROCESS | 1334 | 18:16:20 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:40893/tests/dromaeo/cssquery-yui.html (next: http://localhost:40893/tests/dromaeo/cssquery-dojo.html) 18:16:20 INFO - PROCESS | 1334 | RSS: Main: 171433984 18:16:20 INFO - PROCESS | 1334 | 18:16:20 INFO - PROCESS | 1334 | __start_tp_report 18:16:20 INFO - PROCESS | 1334 | _x_x_mozilla_page_load 18:16:20 INFO - PROCESS | 1334 | _x_x_mozilla_page_load_details 18:16:20 INFO - PROCESS | 1334 | |i|pagename|runs| 18:16:20 INFO - PROCESS | 1334 | |0;dojo.html;2623.5539958207105;2636.9077082302124;2656.375751698351;2677.3842016336243;2680.115561864585;4596.517365676602;4601.378813860128;4666.996595731917;4684.086603112394;4689.460712018111;4663.160631086412;4724.220503616899;4751.524847515247;4772.761361931907;4809.90380192396;4348.282533381988;4388.23205938961;4436.0906014267;4471.217536931024;4514.413126293577;4448.488423831269;4476.6418686505;4500.414946057024;4525.049739554697;4551.726896386227;4303.548127446636;4335.913281734348;4380.408644832971;4385.2106620808245;4389.824407023715;4418.8453404130705;4419.071994881079;4422.690411671184;4442.311441726538;4468.82124715011;4305.526392096866;4388.363687265361;4413.470383553994;4417.226985277595;4448.599626033672;4623.514530974267;4708.10545996263;4725.432948046222;4726.810927562893;4767.713937163781;5179.378474583036;5200.5059519345605;5207.817726379559;5210.635255532115;5215.791368345262;5092.236164575306;5114;5162.974185129088;5239.476052394768;5256.08018596744;4831.154547954094;4835.202191638376;4835.782389792433;4839.637027222972;4883.047805677858;5307.416184219733;5310.336207974004;5318.760655770499;5320.654157479751;5321.920171197435;4906.337644417958;5049.5707864831165;5064.41759197697;5093.719845408464;5121.1550094234035;5018.874528136826;5060.342155519759;5181.53366197044;5197.272381866542;5209.0363282792805;5122;5169.560587350042;5178.3785945686;5180.637355385163;5235.973820130951;4879.487653796371;5043.268726034705;5064.088464076428;5116.718580478109;5143.588512918957;4365.890852728708;4365.934510982338;4366.825326986885;4368.541303163186;4416.006398560298;3790.4314352847296;3817.4655548223272;3829.942550861739;3841.2701586698436;3856.016715737525;4392.121575684812;4413.337999300131;4457.442819647544;4468.955310446854;4472.217361961643;5123.820666276737;5162.6902385856965;5166.535011848951;5168.457311982263;5218;4372.169287835365;4447.799849006802;4450.888727781831;4469.374287599739;4526.569975852289;4576.153411618861;4590.127875703605;4611.953880461219;4619.861404157813;4623.260278355447;4800.567948884547;4815.927761083586;4820.662553621213;4842.661013729005;4897.3878265216845;5038.470960549236;5122.257272695364;5128.974355128201;5156.20078887773;5204.0892843752945;4843.709377437365;4855.1260773061185;4857.587105096107;4877.512248775094;4917.803287868445;5124.333836601218;5125.2568377585785;5125.94918041808;5129.717865517432;5176.378834539879;4965.205567109245;5041.42023667283;5084.872878178076;5182.274481572658;5194.766235519335;4829.927551086666;4881.90236195267;4912.312276281395;4958.5041495851565;4963.230699241623;4963.404391473046;4979.576735977337;4981.526754958273;4985.8504244871265;5024.84925452237;4668.486466488752;4840.903181936271;4845.878853028703;4865.343178670834;4865.878353041202;5021.171506701354;5021.397432308;5072.492750725046;5076.847694569169;5089.160288552495;4886.462489126265;4886.853394398174;4895.16782147043;4898.975505122452;4967.279744437109 18:16:20 INFO - PROCESS | 1334 | |1;ext.html;522.7516929458508;564.5483613109512;583.0700033446652;586.9735861886214;588.088462882532;39758.801205993965;40880.79559602201;40974;41009.58990410099;44765.7761711191;37618.247635047286;37893.431598525975;38007.23985520288;38150.42774358387;38283.808580957055;7533.246675332478;7674.117476490219;7697.99926009618;7748.7675369739;7762.495437796553;7564.546127232356;7654.349380302681;7664.885026724603;7665.1951545087795;7670.27132422419;7699.961500192491;7724.575148366837;7735.419843511759;7749.845003099935;7767.485340358632;7701.884471732928;7707.190744971781;7726.7681969541;7747.767566973;7754.844903101906;7702.537847729154;7747.418943579254;7753.147153813076;7759.107702614158;7761.689532418753;37671.81164094162;38228.23543529142;38228.61771382279;38231.8088409559;38277.617223827685;2998.190488568074;3002.219422950027;3137.984310078435;3155.195425166568;3336.7831090979007;28516.857415712995;28628;28970.56544151818;29017.56473652897;29646.703532964824;3059.2351912021995;3111.1599868035505;3143.182772479149;3150.70068343507;3168.429682657121;248712;249058;250873;251947.74026129936;252962;32456.83771581127;52578.63396147182;52833;52986.20520692193;53009.734951324994;31674.208144796103;33364.332713346084;33648.327033459194;33837.96972181677;33865.32269354599;13836.792448113287;14153.504627337994;14210.85789142116;14245.14529128235;14264.286785660675;11698.35659038761;11833.112516561292;11855.940720296516;11860.703482413008;11904.642860714192;7893.842123157505;7908.802279943047;7950.562719050507;8003;8018.799530011796;3117.0804612639326;3117.267442151093;3118.251619611277;3136.153238625604;3165.4776961801504;885.6103314541581;903.4850135422746;923.5566927874657;982.8967958364269;1025.707673313102;27424.862875685492;28340.149795506168;28573;28734.856325718654;28857.42285154285;1003.8193125237527;1016.3190662256306;1031.6183012285503;1031.7369070886875;1107.4739498738195;14692.41230350774;15203.467878624195;15245;15367.15480648575;15396.538103856903;386274;394269;400385;401839;402721;49927.50072499301;50169.24746128811;50474;50504.242436363485;50525.49474505208;1210.3948025987006;1224.2837939805136;1245.7944439167618;1248.2260998181187;1252.9812052819216;26864.776226852904;27681.584776228774;27967.160985170478;28235.57646635261;28501;43254.56745432506;43296.350554741075;43303.566964329955;43745;43797.34303985379;344062;347137;348105;348592;349621;24733.381665458506;24991.375215619755;25094.62358064594;26699.733002670502;27590.172294831187;42175.78912105542;42657.5734242666;42734.14531709411;42798;43185.78407107944;35988.82005589955;36317.27365452623;36440;36577.45133822942;36715.63284367122;35950.28099438049;36046;36094.278114438086;36148.09629759277;36190.63809361978;34838.47742283918;36175.095622609646;36313.63686363103;36331.09172270714;37249;31296;32653.673463265062;33115.66884331126;33396.66603333935;33542.664573353955;24801.775769149895;25237.583422900552;25868.482630346913;26804.59793103144;27424.45151097007 18:16:20 INFO - PROCESS | 1334 | |2;jquery.html;362.791394947905;373.60957799099936;376.74946160803063;383.1933779394375;387.2931899283808;15802.209889505522;16370.345186192553;17226.655466890672;17329.353711397427;17403.91298043508;15767.369305227778;15853.603659908507;16475;16581.336746530156;16685.24916378763;5015.272785446117;5130.410002849682;5151.381834179903;5205;5212.6611770235;3706.8887933362043;5147.253648221005;5822.7088645567765;6121.632702037892;6180.165677633529;6075.817725468243;6104.572679912408;6111.602745821508;6126.111713801496;6158.907616385758;4998.200287953928;5307.336582927153;5317.282166907476;5352.678839269617;5379.462053794589;5049.2173713074535;5184.870378240536;5280.128778751501;5280.815171469018;5338.0925242708445;11891.762164756743;12104.092193085553;12114.939425302906;12279;12299.508019679202;1752.535578071812;1794.596215851436;1819.8362147406665;1845.2342277954633;1873.3536929759211;8748.781280467976;9089.909100908972;9239.953800230956;10066.798664026752;13474.797878031837;1612.733898906679;1758.103367282695;1783.0995347349635;1820.417466410749;1825.954351141219;52521.737391312796;66563.33436665668;67396;68009.65995170042;68411;9521.285903557122;9727.124558789601;9904.55429505674;10016.29885907994;10053.59785608582;13489.865101349058;13506.392212350467;13563.59309220725;13645.249511276777;13719.588412347646;7450.515716478411;7513.586752728653;7523.924760752432;7581.772546823494;7602.847943041219;7218.242084581148;7272.454565907578;7370.705171793175;7448.925510744932;7460.29127232912;4250.055882572101;4275.209086319041;4342.457192850894;4351.151525452507;4435.800388982503;1605.662810809743;1721.6556688662317;1817.354839032151;1821.8087100854484;1827.3695575026595;783.2519943454101;860.4020205956925;862.5169904853302;923.7275003873873;997.3666721631816;16233.431829885898;16417.58956026109;16428.507144785675;16691;16746.162691865356;829.4359835311925;829.4898637337993;859.3254295378098;890.4212262029732;924.8196601662746;8790.604422800989;8974.41666291689;9045.366824322366;9171;9314.161725444743;382180;400004;406652;409666;412137;78786.6060669693;79413.60293198613;79550;81759.59120204361;81777.59111204406;929.702495201529;953.8903026151943;956.5217391304348;956.5408603870181;956.8469044952774;14461.349239284467;14502.709945801236;14583.125012499284;14589.562313130624;14700.926495367456;33729;33848;34187.17980757216;34405.311893761485;34554.65445345514;45220.54779452295;46188.53811461842;48490.5150948486;49554.25668615046;50187.494375168804;7285.927140728525;7865.685372585262;7899.447038707235;7930.881036784337;8051.315638170821;8610.052894181761;11491.310521368745;11934.164608477324;11988.76022479528;12049.33728644933;10298.536565854405;10337.896621033693;10500.26498145153;10567;10760.40817755031;10441;10486.580536778443;10492.265541412027;10531.894681053398;10687.572497100029;10561.841572376574;10648.627298044532;10659.09397701204;10688.770791359093;10906.34561926287;6511.674416279072;7858.5677787722225;7875.212478752079;7885.960570197112;7892.4080693947035;8733.825323493367;10812;10994.560217591206;11013.504392302206;11082.61210857616 18:16:20 INFO - PROCESS | 1334 | |3;mootools.html;1176.2119380015388;1187.0681515010715;1302.3488255872064;1386.9375878085484;1387.084524214019;6431.485481161508;7252.8549429011455;7437.665305061271;7635.885461718079;7728.304452599265;7337.743178988737;7567.091948966118;7575;7585.544867307952;7585.696572137108;2147.3235930681826;2175.9456013599706;2184.290105715641;2186.5954798362354;2187.7593464718866;2087.5824835032977;2124.60694771467;2169.381726208031;2180.411288951982;2182.978170218293;2131.7015617813518;2136.8931553422344;2141.8072373486384;2146.0557354763932;2188.9890550547225;2075.0765909170427;2092.73840769903;2093.2464312847364;2095.476130967258;2099.4751312171957;2075.533005073861;2105.9157633694635;2114.851960362775;2122.2466024561368;2127.1066152215953;7549.886751698729;7623.923760762377;7679.2704693054075;7693.346065584432;7713.65288562016;4354.499232588261;4454.799534020977;4458.554144585548;4464.397306363664;4473.753943533105;2696.245051385615;2785.9860700696568;2787.860606969664;2849.1594979480897;2854.100958198161;874.9168828961302;881.1981097201516;906.0441234497603;922.1562270522531;926.56914534741;10153.64462243818;10161.745956351077;10164.59341626334;10165.59337626494;10173.745656358577;4037.4953130858644;4114.753114813121;4164.979175104105;4177.874663760092;4193.161367726467;8794.736157915273;8839.779005524913;8856.247218986458;8906.73279801607;8914.643414263357;4481.3726078349055;4517;4572.702774319659;4579.358889755437;4582.312653102062;3502.772319799205;4056.553779084298;4140.91718165635;4141.855035073758;4183.623473887304;3638.399664055454;3645.2709458108484;3700.9814950925074;3753.3806921857586;3850.114473671071;1117.3519358771894;1145.3013661666378;1146.2148428326623;1157.5543415784985;1161.936093514848;683.7606837606797;794.7337641890032;799.6441583495289;827.1893544326473;839.6053854688287;4898.706077635354;5146.2280657900865;5165.199394093921;5178.508041736104;5203.2195170723935;386.77567011133476;387.30285486124865;396.6806720589895;396.7222943939254;403.4311620614919;3508.210652603144;3610.4403817408343;3610.891673249807;3624.3838547447;3646.34365814156;8974.326925480615;9430.669926552539;9438.716838494856;9443.716688499357;9449.291303152291;8911.866322005175;9366.29752768545;9369.765755856022;9376.5311734413;9401;6979.371856532936;7242.311980361857;7256.96371518139;7297.708091676273;7298.744543940937;4906.533879281463;4925.581325587365;5176.50823171798;5374.785008599612;5435.429279925551;8616;8750.256228220673;8760.4305720128;8825.867611985954;8882.15619516145;8270.958645206736;8584.871226931726;8644.438111522732;8756.605952732016;8834.116588341114;5705.258316418839;6477.4494167996245;6503.284638689645;6687.598744075371;6750.45996320303;7337.59643219628;7399.371053460516;7415.592142432218;7457.216992215739;7467.738629147953;6732.192136943598;6787.626680532618;6904.585724856524;6911.619860907497;6918.827029324307;6530.67346632676;6590.7693230736695;6618.437432818265;6710.228323742636;6818.829529261808;6262.624242545462;6293.244810622755;6326.462250708557;6343.429091381798;6345.746170153142;4608.815647374067;4662;4666;4745.928811067905;4763.642726795435;4502.797374118238;4515.571020753023;4579.656525760514;4590.472095709036;4636.258198688193 18:16:20 INFO - PROCESS | 1334 | |4;prototype.html;282.1465068168789;292.7716381222646;298.54173843150767;300.4456777245981;302.7320821073352;4833.250846118857;4983.576396006335;5012.7744251508675;5066.797328106876;5080.364954380702;4975.800967961277;4981.227909673998;5002.274670172823;5010.423801262847;5018.473060328668;3908.335582950891;3924.489816323874;3940.428637847525;3948.8223029963647;3950.6444420002194;3645.3985092459843;3935.311320518912;3940.074082590603;3941.3052387473376;3966.266240745457;3815.2831225948294;3830;3834;3841.519810023747;3842.442845787359;3819.3888977763563;3837.079101015764;3840.9807950960344;3857.9228415431535;3895.61043895611;3387.2548039431285;3393.06690660068;3397.403220486392;3426.5202871597994;3428.142964258935;4648.651351148677;4818.975905120452;4848.163824162869;4857.878553036167;4878.804847806119;4387.319965405367;4397.31841564558;4418.624416924533;4422.380866678667;4436.778161091965;5256.9474305256845;5265.447128051538;5278.261043453919;5278.392984806719;5298.788048478056;3611.3138503684218;3685.94471082934;3689.5572531296416;3690.0774806298427;3702.777833330009;5409.6213265071465;5485.588580856412;5503.147012213113;5542.168674698787;5557.888842223173;3714.6998550507647;3716.851325946986;3726.496922915426;3738.345789486829;3771.9434208486896;3790.639889210521;3794.6964242860504;3812.866549670748;3816.7709937403843;3829.195868867569;4309.806058727365;4342.478902531717;4362.367456718758;4370.169667763115;4373.972116552608;5205.375354957429;5229.816956406507;5238.214267859851;5240.895182096413;5270.60470464709;1235.7837378458735;1265.702559898423;1303.5567906911695;1306.6933066933068;1311.7966715159166;794.1899262751961;804.4368941740805;827.9981222720455;835.4694768821842;837.1586555511672;4171.416001759756;4207.915841683149;4244.580589064204;4255.829766809355;4257.19113368459;4727.503612120678;4755.310479980452;4849.393825771778;4877.780499877443;4887.926681099786;4230.365445183247;4232.576742325743;4247.787610619456;4266.786660666954;4267;2514.597664373728;2546.185220729386;2577.718718933757;2596.9220923372327;2637.720705457851;4479;4523.705959112647;4535.365048893158;4535.614472769786;4535.614472769786;4852.519981405705;4861.961274203622;4878.243872199815;4895.461499235082;4941.196463290945;4270.893227669333;4427.867163985085;4504.851262927932;4525.434320709977;4532.410786597721;4759.762011899322;4808.495108013748;4809.254565542346;4821.63837712166;4836.419629644324;4680.742559159279;4692.718436893797;4694.201985662377;4705.011947491065;4719.952800471951;4497.572730590588;4752.334673145693;5217.4260831307765;5219.634625576173;5225.764840582106;3790.2608991246443;3791;3798.1454172810895;3799.582045974885;3799.7530160539477;5253.343332083489;5457.69982650958;5533.806316779054;5538.750756215899;5540.833774986757;5122.7449274927885;5236.816711415082;5264.894702106013;5291.417944026077;5313.203019547099;5283.471652834686;5306.469353064663;5310.628256022042;5312;5343.679379237103;4898.853034408973;5110.872228194176;5165.509276618715;5177.119889618699;5178.637495375438;5312.442193569619;5327.6270661054905;5328.786848526015;5333.466653334635;5335.893282134413;5185.429602743619;5208.270842082187;5214.582833373245;5249.448807875118;5251.186066159751 18:16:20 INFO - PROCESS | 1334 | |5;yui.html;586.6463875322828;631.8136149835798;658.4403257231353;669.83923858274;725.9927400725991;12780.936095319523;13363.465461381533;13453.59639210824;13510.797338039913;13521.053526253167;13463.596092117228;13475.932620336884;13479.39342729577;13507.93246033771;13527.729445411085;628.2241431831684;769.7152053740124;779.2752739951843;781.03932163439;782.5930516131608;765.4412279036306;775.5540564175593;777.7472321495509;778.0857492446381;783.5142211828675;819.3608984991716;828.362161135925;828.5153185386556;828.8756686497044;829.4940086547201;817.7710241132493;821.9013718353776;823.0945959444623;823.217942954193;823.8146417056114;596.764278110144;597.011945230644;597.0894386061248;599.811059516251;601.7923816283375;12634.2419454833;12688.365581720876;12689.555865544662;12724.681882952907;12798.616041518677;12462.43919023646;12583;12823.35883205836;12928.543576720393;13044.369044109208;9290.907090929071;9930;10120.696379108565;10159.23805714567;10203.03071208234;3192.712655860984;3255.690709382605;3298.1259966109;3327.9516952159993;3381.3744457275484;55584;55732.16401753977;55868.44131558714;56238.718806405705;56315;9307.72076837696;9558.474283914451;9657.372270802376;9800.509974501247;9854.408735475894;17937.372191973478;18030.36893708714;18061.367852125375;18075.54811129732;18107.18517666708;6249.250089989139;6468.967655161694;6478.125453063871;6602.2407423146;6690.598564086073;3261.641219465904;3282.950755738666;3293.4565796643765;3316.701496865294;3334.9166270843425;2922.678505364408;3017.230606195406;3025.9394812104074;3030.045535656261;3030.075826872825;474.5231042801962;474.83618151737596;476.6996792021074;494.88617617948074;495.79920132346456;554.6006875049958;583.7023118209744;584.8567101060182;601.3565484931082;605.6608299352376;7427.962860185665;7932.206779322021;7984.560849153236;8045;8125.837483250302;452.4412350746825;536.7235873525137;564.3145310991692;580.7096451774113;587.524105474567;3684.9447258291148;3707.962920370816;3722.590515043343;3789.2800367930004;3813.122981714221;73721;88187.55906220428;92395;92494;92704;49765.751171244636;49793.00413991772;50341.74829125831;64366;81867;47310;72523;72870;73017.6349118251;73269;7081.539699919489;7204.063471748639;7208.06295181623;7215.134183897756;7269.927300727137;42637.36043959281;42712.572874272104;43296.350554742334;43337.56662433461;43347.349789752545;56589.43410566006;59398;59846.401535984085;59931.40754517087;60056.699716501134;9259.72220833376;9312.767180820534;9339.906600933904;9375.24998000172;9443.763905902408;10313.329633573794;10479.109275711346;10618.52216650268;10629.415382154055;10847.24069315172;10396.792064158826;10407.427591482237;10456.581736730446;10560.471976401303;10928.125749940145;9739.756506087404;9890.159336456481;10109.64616238428;10142;10581.4709264538;10223.386596804216;10564.683059508227;10680.732981675521;10762.51568679427;10973.122150228122;9464.479453629841;9792.167665748491;9860.605575776888;9879.604815807288;10265.12746416533;9531.142197202285;9560.139587437165;9640;9863.901360986298;9894.109530142034 18:16:20 INFO - PROCESS | 1334 | __end_tp_report 18:16:20 INFO - PROCESS | 1334 | __start_cc_report 18:16:20 INFO - PROCESS | 1334 | _x_x_mozilla_cycle_collect,392 18:16:20 INFO - PROCESS | 1334 | __end_cc_report 18:16:20 INFO - PROCESS | 1334 | __startTimestamp1465348580597__endTimestamp 18:16:20 INFO - PROCESS | 1334 | 18:16:20 INFO - PROCESS | 1334 | ------- Summary: start ------- 18:16:20 INFO - PROCESS | 1334 | Number of tests: 6 18:16:20 INFO - PROCESS | 1334 | 18:16:20 INFO - PROCESS | 1334 | [#0] dojo.html Cycles:165 Average:4740.41 Median:4845.88 stddev:501.24 (10.3%) stddev-sans-first:474.47 18:16:20 INFO - PROCESS | 1334 | Values: 2623.6 2636.9 2656.4 2677.4 2680.1 4596.5 4601.4 4667.0 4684.1 4689.5 4663.2 4724.2 4751.5 4772.8 4809.9 4348.3 4388.2 4436.1 4471.2 4514.4 4448.5 4476.6 4500.4 4525.0 4551.7 4303.5 4335.9 4380.4 4385.2 4389.8 4418.8 4419.1 4422.7 4442.3 4468.8 4305.5 4388.4 4413.5 4417.2 4448.6 4623.5 4708.1 4725.4 4726.8 4767.7 5179.4 5200.5 5207.8 5210.6 5215.8 5092.2 5114.0 5163.0 5239.5 5256.1 4831.2 4835.2 4835.8 4839.6 4883.0 5307.4 5310.3 5318.8 5320.7 5321.9 4906.3 5049.6 5064.4 5093.7 5121.2 5018.9 5060.3 5181.5 5197.3 5209.0 5122.0 5169.6 5178.4 5180.6 5236.0 4879.5 5043.3 5064.1 5116.7 5143.6 4365.9 4365.9 4366.8 4368.5 4416.0 3790.4 3817.5 3829.9 3841.3 3856.0 4392.1 4413.3 4457.4 4469.0 4472.2 5123.8 5162.7 5166.5 5168.5 5218.0 4372.2 4447.8 4450.9 4469.4 4526.6 4576.2 4590.1 4612.0 4619.9 4623.3 4800.6 4815.9 4820.7 4842.7 4897.4 5038.5 5122.3 5129.0 5156.2 5204.1 4843.7 4855.1 4857.6 4877.5 4917.8 5124.3 5125.3 5125.9 5129.7 5176.4 4965.2 5041.4 5084.9 5182.3 5194.8 4829.9 4881.9 4912.3 4958.5 4963.2 4963.4 4979.6 4981.5 4985.9 5024.8 4668.5 4840.9 4845.9 4865.3 4865.9 5021.2 5021.4 5072.5 5076.8 5089.2 4886.5 4886.9 4895.2 4899.0 4967.3 18:16:20 INFO - PROCESS | 1334 | 18:16:20 INFO - PROCESS | 1334 | [#1] ext.html Cycles:180 Average:47522.24 Median:36070.14 stddev:89100.09 (247.0%) stddev-sans-first:89280.16 18:16:20 INFO - PROCESS | 1334 | Values: 522.8 564.5 583.1 587.0 588.1 39758.8 40880.8 40974.0 41009.6 44765.8 37618.2 37893.4 38007.2 38150.4 38283.8 7533.2 7674.1 7698.0 7748.8 7762.5 7564.5 7654.3 7664.9 7665.2 7670.3 7700.0 7724.6 7735.4 7749.8 7767.5 7701.9 7707.2 7726.8 7747.8 7754.8 7702.5 7747.4 7753.1 7759.1 7761.7 37671.8 38228.2 38228.6 38231.8 38277.6 2998.2 3002.2 3138.0 3155.2 3336.8 28516.9 28628.0 28970.6 29017.6 29646.7 3059.2 3111.2 3143.2 3150.7 3168.4 248712.0 249058.0 250873.0 251947.7 252962.0 32456.8 52578.6 52833.0 52986.2 53009.7 31674.2 33364.3 33648.3 33838.0 33865.3 13836.8 14153.5 14210.9 14245.1 14264.3 11698.4 11833.1 11855.9 11860.7 11904.6 7893.8 7908.8 7950.6 8003.0 8018.8 3117.1 3117.3 3118.3 3136.2 3165.5 885.6 903.5 923.6 982.9 1025.7 27424.9 28340.1 28573.0 28734.9 28857.4 1003.8 1016.3 1031.6 1031.7 1107.5 14692.4 15203.5 15245.0 15367.2 15396.5 386274.0 394269.0 400385.0 401839.0 402721.0 49927.5 50169.2 50474.0 50504.2 50525.5 1210.4 1224.3 1245.8 1248.2 1253.0 26864.8 27681.6 27967.2 28235.6 28501.0 43254.6 43296.4 43303.6 43745.0 43797.3 344062.0 347137.0 348105.0 348592.0 349621.0 24733.4 24991.4 25094.6 26699.7 27590.2 42175.8 42657.6 42734.1 42798.0 43185.8 35988.8 36317.3 36440.0 36577.5 36715.6 35950.3 36046.0 36094.3 36148.1 36190.6 34838.5 36175.1 36313.6 36331.1 37249.0 31296.0 32653.7 33115.7 33396.7 33542.7 24801.8 25237.6 25868.5 26804.6 27424.5 18:16:20 INFO - PROCESS | 1334 | 18:16:20 INFO - PROCESS | 1334 | [#2] jquery.html Cycles:180 Average:24211.47 Median:4346.80 stddev:66322.08 (1525.8%) stddev-sans-first:66483.95 18:16:20 INFO - PROCESS | 1334 | Values: 362.8 373.6 376.7 383.2 387.3 15802.2 16370.3 17226.7 17329.4 17403.9 15767.4 15853.6 16475.0 16581.3 16685.2 5015.3 5130.4 5151.4 5205.0 5212.7 3706.9 5147.3 5822.7 6121.6 6180.2 6075.8 6104.6 6111.6 6126.1 6158.9 4998.2 5307.3 5317.3 5352.7 5379.5 5049.2 5184.9 5280.1 5280.8 5338.1 11891.8 12104.1 12114.9 12279.0 12299.5 1752.5 1794.6 1819.8 1845.2 1873.4 8748.8 9089.9 9240.0 10066.8 13474.8 1612.7 1758.1 1783.1 1820.4 1826.0 52521.7 66563.3 67396.0 68009.7 68411.0 9521.3 9727.1 9904.6 10016.3 10053.6 13489.9 13506.4 13563.6 13645.2 13719.6 7450.5 7513.6 7523.9 7581.8 7602.8 7218.2 7272.5 7370.7 7448.9 7460.3 4250.1 4275.2 4342.5 4351.2 4435.8 1605.7 1721.7 1817.4 1821.8 1827.4 783.3 860.4 862.5 923.7 997.4 16233.4 16417.6 16428.5 16691.0 16746.2 829.4 829.5 859.3 890.4 924.8 8790.6 8974.4 9045.4 9171.0 9314.2 382180.0 400004.0 406652.0 409666.0 412137.0 78786.6 79413.6 79550.0 81759.6 81777.6 929.7 953.9 956.5 956.5 956.8 14461.3 14502.7 14583.1 14589.6 14700.9 33729.0 33848.0 34187.2 34405.3 34554.7 45220.5 46188.5 48490.5 49554.3 50187.5 7285.9 7865.7 7899.4 7930.9 8051.3 8610.1 11491.3 11934.2 11988.8 12049.3 10298.5 10337.9 10500.3 10567.0 10760.4 10441.0 10486.6 10492.3 10531.9 10687.6 10561.8 10648.6 10659.1 10688.8 10906.3 6511.7 7858.6 7875.2 7886.0 7892.4 8733.8 10812.0 10994.6 11013.5 11082.6 18:16:20 INFO - PROCESS | 1334 | 18:16:20 INFO - PROCESS | 1334 | [#3] mootools.html Cycles:180 Average:5010.30 Median:4902.62 stddev:2809.82 (57.3%) stddev-sans-first:2802.92 18:16:20 INFO - PROCESS | 1334 | Values: 1176.2 1187.1 1302.3 1386.9 1387.1 6431.5 7252.9 7437.7 7635.9 7728.3 7337.7 7567.1 7575.0 7585.5 7585.7 2147.3 2175.9 2184.3 2186.6 2187.8 2087.6 2124.6 2169.4 2180.4 2183.0 2131.7 2136.9 2141.8 2146.1 2189.0 2075.1 2092.7 2093.2 2095.5 2099.5 2075.5 2105.9 2114.9 2122.2 2127.1 7549.9 7623.9 7679.3 7693.3 7713.7 4354.5 4454.8 4458.6 4464.4 4473.8 2696.2 2786.0 2787.9 2849.2 2854.1 874.9 881.2 906.0 922.2 926.6 10153.6 10161.7 10164.6 10165.6 10173.7 4037.5 4114.8 4165.0 4177.9 4193.2 8794.7 8839.8 8856.2 8906.7 8914.6 4481.4 4517.0 4572.7 4579.4 4582.3 3502.8 4056.6 4140.9 4141.9 4183.6 3638.4 3645.3 3701.0 3753.4 3850.1 1117.4 1145.3 1146.2 1157.6 1161.9 683.8 794.7 799.6 827.2 839.6 4898.7 5146.2 5165.2 5178.5 5203.2 386.8 387.3 396.7 396.7 403.4 3508.2 3610.4 3610.9 3624.4 3646.3 8974.3 9430.7 9438.7 9443.7 9449.3 8911.9 9366.3 9369.8 9376.5 9401.0 6979.4 7242.3 7257.0 7297.7 7298.7 4906.5 4925.6 5176.5 5374.8 5435.4 8616.0 8750.3 8760.4 8825.9 8882.2 8271.0 8584.9 8644.4 8756.6 8834.1 5705.3 6477.4 6503.3 6687.6 6750.5 7337.6 7399.4 7415.6 7457.2 7467.7 6732.2 6787.6 6904.6 6911.6 6918.8 6530.7 6590.8 6618.4 6710.2 6818.8 6262.6 6293.2 6326.5 6343.4 6345.7 4608.8 4662.0 4666.0 4745.9 4763.6 4502.8 4515.6 4579.7 4590.5 4636.3 18:16:20 INFO - PROCESS | 1334 | 18:16:20 INFO - PROCESS | 1334 | [#4] prototype.html Cycles:180 Average:4216.66 Median:4592.13 stddev:1237.18 (26.9%) stddev-sans-first:1204.89 18:16:20 INFO - PROCESS | 1334 | Values: 282.1 292.8 298.5 300.4 302.7 4833.3 4983.6 5012.8 5066.8 5080.4 4975.8 4981.2 5002.3 5010.4 5018.5 3908.3 3924.5 3940.4 3948.8 3950.6 3645.4 3935.3 3940.1 3941.3 3966.3 3815.3 3830.0 3834.0 3841.5 3842.4 3819.4 3837.1 3841.0 3857.9 3895.6 3387.3 3393.1 3397.4 3426.5 3428.1 4648.7 4819.0 4848.2 4857.9 4878.8 4387.3 4397.3 4418.6 4422.4 4436.8 5256.9 5265.4 5278.3 5278.4 5298.8 3611.3 3685.9 3689.6 3690.1 3702.8 5409.6 5485.6 5503.1 5542.2 5557.9 3714.7 3716.9 3726.5 3738.3 3771.9 3790.6 3794.7 3812.9 3816.8 3829.2 4309.8 4342.5 4362.4 4370.2 4374.0 5205.4 5229.8 5238.2 5240.9 5270.6 1235.8 1265.7 1303.6 1306.7 1311.8 794.2 804.4 828.0 835.5 837.2 4171.4 4207.9 4244.6 4255.8 4257.2 4727.5 4755.3 4849.4 4877.8 4887.9 4230.4 4232.6 4247.8 4266.8 4267.0 2514.6 2546.2 2577.7 2596.9 2637.7 4479.0 4523.7 4535.4 4535.6 4535.6 4852.5 4862.0 4878.2 4895.5 4941.2 4270.9 4427.9 4504.9 4525.4 4532.4 4759.8 4808.5 4809.3 4821.6 4836.4 4680.7 4692.7 4694.2 4705.0 4720.0 4497.6 4752.3 5217.4 5219.6 5225.8 3790.3 3791.0 3798.1 3799.6 3799.8 5253.3 5457.7 5533.8 5538.8 5540.8 5122.7 5236.8 5264.9 5291.4 5313.2 5283.5 5306.5 5310.6 5312.0 5343.7 4898.9 5110.9 5165.5 5177.1 5178.6 5312.4 5327.6 5328.8 5333.5 5335.9 5185.4 5208.3 5214.6 5249.4 5251.2 18:16:20 INFO - PROCESS | 1334 | 18:16:20 INFO - PROCESS | 1334 | [#5] yui.html Cycles:180 Average:15965.17 Median:28585.07 stddev:22162.15 (77.5%) stddev-sans-first:22194.24 18:16:20 INFO - PROCESS | 1334 | Values: 586.6 631.8 658.4 669.8 726.0 12780.9 13363.5 13453.6 13510.8 13521.1 13463.6 13475.9 13479.4 13507.9 13527.7 628.2 769.7 779.3 781.0 782.6 765.4 775.6 777.7 778.1 783.5 819.4 828.4 828.5 828.9 829.5 817.8 821.9 823.1 823.2 823.8 596.8 597.0 597.1 599.8 601.8 12634.2 12688.4 12689.6 12724.7 12798.6 12462.4 12583.0 12823.4 12928.5 13044.4 9290.9 9930.0 10120.7 10159.2 10203.0 3192.7 3255.7 3298.1 3328.0 3381.4 55584.0 55732.2 55868.4 56238.7 56315.0 9307.7 9558.5 9657.4 9800.5 9854.4 17937.4 18030.4 18061.4 18075.5 18107.2 6249.3 6469.0 6478.1 6602.2 6690.6 3261.6 3283.0 3293.5 3316.7 3334.9 2922.7 3017.2 3025.9 3030.0 3030.1 474.5 474.8 476.7 494.9 495.8 554.6 583.7 584.9 601.4 605.7 7428.0 7932.2 7984.6 8045.0 8125.8 452.4 536.7 564.3 580.7 587.5 3684.9 3708.0 3722.6 3789.3 3813.1 73721.0 88187.6 92395.0 92494.0 92704.0 49765.8 49793.0 50341.7 64366.0 81867.0 47310.0 72523.0 72870.0 73017.6 73269.0 7081.5 7204.1 7208.1 7215.1 7269.9 42637.4 42712.6 43296.4 43337.6 43347.3 56589.4 59398.0 59846.4 59931.4 60056.7 9259.7 9312.8 9339.9 9375.2 9443.8 10313.3 10479.1 10618.5 10629.4 10847.2 10396.8 10407.4 10456.6 10560.5 10928.1 9739.8 9890.2 10109.6 10142.0 10581.5 10223.4 10564.7 10680.7 10762.5 10973.1 9464.5 9792.2 9860.6 9879.6 10265.1 9531.1 9560.1 9640.0 9863.9 9894.1 18:16:20 INFO - PROCESS | 1334 | -------- Summary: end -------- 18:16:20 INFO - PROCESS | 1334 | 18:16:21 INFO - TEST-INFO | 1334: exit 0 18:16:21 INFO - TEST-OK | dromaeo_css | took 1115263ms 18:16:21 INFO - TEST-START | kraken 18:16:21 INFO - operating with platform_type : linux_ 18:16:21 INFO - Initialising browser for kraken test... 18:16:21 INFO - TEST-INFO | started process 1572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNipXWJ/profile http://localhost:40893/getInfo.html) 18:16:26 INFO - PROCESS | 1572 | __metrics Screen width/height:1600/1200 18:16:26 INFO - PROCESS | 1572 | colorDepth:24 18:16:26 INFO - PROCESS | 1572 | Browser inner width/height: 1024/697 18:16:26 INFO - PROCESS | 1572 | __metrics 18:16:26 ERROR - PROCESS | 1572 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 18:16:27 INFO - TEST-INFO | 1572: exit 0 18:16:27 INFO - Browser initialized. 18:16:27 INFO - Running cycle 1/1 for kraken test... 18:16:27 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNipXWJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:16:39 INFO - PROCESS | 1692 | RSS: Main: 167862272 18:16:39 INFO - PROCESS | 1692 | 18:16:42 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40893/tests/kraken/driver.html?testName=audio-beat-detection) 18:16:43 INFO - PROCESS | 1692 | RSS: Main: 172957696 18:16:43 INFO - PROCESS | 1692 | 18:16:46 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40893/tests/kraken/driver.html?testName=audio-dft) 18:16:46 INFO - PROCESS | 1692 | RSS: Main: 172584960 18:16:46 INFO - PROCESS | 1692 | 18:16:49 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40893/tests/kraken/driver.html?testName=audio-fft) 18:16:50 INFO - PROCESS | 1692 | RSS: Main: 167424000 18:16:50 INFO - PROCESS | 1692 | 18:16:52 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40893/tests/kraken/driver.html?testName=audio-oscillator) 18:16:53 INFO - PROCESS | 1692 | RSS: Main: 167841792 18:16:53 INFO - PROCESS | 1692 | 18:16:55 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40893/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:16:56 INFO - PROCESS | 1692 | RSS: Main: 168316928 18:16:56 INFO - PROCESS | 1692 | 18:16:59 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40893/tests/kraken/driver.html?testName=imaging-darkroom) 18:16:59 INFO - PROCESS | 1692 | RSS: Main: 168734720 18:16:59 INFO - PROCESS | 1692 | 18:17:03 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40893/tests/kraken/driver.html?testName=imaging-desaturate) 18:17:04 INFO - PROCESS | 1692 | RSS: Main: 166232064 18:17:04 INFO - PROCESS | 1692 | 18:17:06 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40893/tests/kraken/driver.html?testName=json-parse-financial) 18:17:07 INFO - PROCESS | 1692 | RSS: Main: 167784448 18:17:07 INFO - PROCESS | 1692 | 18:17:09 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40893/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:17:09 INFO - PROCESS | 1692 | RSS: Main: 168333312 18:17:09 INFO - PROCESS | 1692 | 18:17:11 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40893/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:17:12 INFO - PROCESS | 1692 | RSS: Main: 168271872 18:17:12 INFO - PROCESS | 1692 | 18:17:14 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40893/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:17:15 INFO - PROCESS | 1692 | RSS: Main: 168591360 18:17:15 INFO - PROCESS | 1692 | 18:17:18 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:17:18 INFO - PROCESS | 1692 | RSS: Main: 168542208 18:17:18 INFO - PROCESS | 1692 | 18:17:21 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:17:22 INFO - PROCESS | 1692 | RSS: Main: 167981056 18:17:22 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:40893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40893/tests/kraken/driver.html?testName=ai-astar) 18:17:24 INFO - PROCESS | 1692 | RSS: Main: 168910848 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | __start_tp_report 18:17:24 INFO - PROCESS | 1692 | _x_x_mozilla_page_load 18:17:24 INFO - PROCESS | 1692 | _x_x_mozilla_page_load_details 18:17:24 INFO - PROCESS | 1692 | |i|pagename|runs| 18:17:24 INFO - PROCESS | 1692 | |0;ai-astar;116;111;118;115;117;118;117;116;115;115 18:17:24 INFO - PROCESS | 1692 | |1;audio-beat-detection;169;132;157;182;135;161;155;134;201;136 18:17:24 INFO - PROCESS | 1692 | |2;audio-dft;163;163;166;176;163;165;164;164;161;163 18:17:24 INFO - PROCESS | 1692 | |3;audio-fft;78;78;77;161;79;76;77;75;156;78 18:17:24 INFO - PROCESS | 1692 | |4;audio-oscillator;86;86;149;86;86;88;132;90;85;142 18:17:24 INFO - PROCESS | 1692 | |5;imaging-gaussian-blur;118;118;117;118;118;119;118;117;118;118 18:17:24 INFO - PROCESS | 1692 | |6;imaging-darkroom;148;150;147;147;148;150;147;148;147;148 18:17:24 INFO - PROCESS | 1692 | |7;imaging-desaturate;95;95;96;95;96;96;95;96;96;95 18:17:24 INFO - PROCESS | 1692 | |8;json-parse-financial;62;63;63;62;64;62;63;63;63;62 18:17:24 INFO - PROCESS | 1692 | |9;json-stringify-tinderbox;65;65;64;65;69;64;65;66;65;65 18:17:24 INFO - PROCESS | 1692 | |10;stanford-crypto-aes;85;83;86;86;85;86;86;89;115;89 18:17:24 INFO - PROCESS | 1692 | |11;stanford-crypto-ccm;141;132;136;132;137;148;132;136;138;136 18:17:24 INFO - PROCESS | 1692 | |12;stanford-crypto-pbkdf2;178;170;170;171;172;170;172;169;166;169 18:17:24 INFO - PROCESS | 1692 | |13;stanford-crypto-sha256-iterative;70;72;68;67;68;71;67;67;68;68 18:17:24 INFO - PROCESS | 1692 | __end_tp_report 18:17:24 INFO - PROCESS | 1692 | __start_cc_report 18:17:24 INFO - PROCESS | 1692 | _x_x_mozilla_cycle_collect,987 18:17:24 INFO - PROCESS | 1692 | __end_cc_report 18:17:24 INFO - PROCESS | 1692 | __startTimestamp1465348644391__endTimestamp 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | ------- Summary: start ------- 18:17:24 INFO - PROCESS | 1692 | Number of tests: 14 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.50 stddev:2.04 (1.8%) stddev-sans-first:2.17 18:17:24 INFO - PROCESS | 1692 | Values: 116.0 111.0 118.0 115.0 117.0 118.0 117.0 116.0 115.0 115.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:159.00 stddev:23.09 (14.5%) stddev-sans-first:24.02 18:17:24 INFO - PROCESS | 1692 | Values: 169.0 132.0 157.0 182.0 135.0 161.0 155.0 134.0 201.0 136.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:4.16 (2.5%) stddev-sans-first:4.36 18:17:24 INFO - PROCESS | 1692 | Values: 163.0 163.0 166.0 176.0 163.0 165.0 164.0 164.0 161.0 163.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#3] audio-fft Cycles:10 Average:93.50 Median:77.50 stddev:34.30 (44.3%) stddev-sans-first:35.92 18:17:24 INFO - PROCESS | 1692 | Values: 78.0 78.0 77.0 161.0 79.0 76.0 77.0 75.0 156.0 78.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:86.00 stddev:26.57 (30.9%) stddev-sans-first:27.46 18:17:24 INFO - PROCESS | 1692 | Values: 86.0 86.0 149.0 86.0 86.0 88.0 132.0 90.0 85.0 142.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 18:17:24 INFO - PROCESS | 1692 | Values: 118.0 118.0 117.0 118.0 118.0 119.0 118.0 117.0 118.0 118.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.15 (0.8%) stddev-sans-first:1.22 18:17:24 INFO - PROCESS | 1692 | Values: 148.0 150.0 147.0 147.0 148.0 150.0 147.0 148.0 147.0 148.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:17:24 INFO - PROCESS | 1692 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 18:17:24 INFO - PROCESS | 1692 | Values: 62.0 63.0 63.0 62.0 64.0 62.0 63.0 63.0 63.0 62.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.50 18:17:24 INFO - PROCESS | 1692 | Values: 65.0 65.0 64.0 65.0 69.0 64.0 65.0 66.0 65.0 65.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:86.00 stddev:9.31 (10.8%) stddev-sans-first:9.76 18:17:24 INFO - PROCESS | 1692 | Values: 85.0 83.0 86.0 86.0 85.0 86.0 86.0 89.0 115.0 89.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:136.50 stddev:4.89 (3.6%) stddev-sans-first:4.95 18:17:24 INFO - PROCESS | 1692 | Values: 141.0 132.0 136.0 132.0 137.0 148.0 132.0 136.0 138.0 136.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:170.50 stddev:3.09 (1.8%) stddev-sans-first:1.83 18:17:24 INFO - PROCESS | 1692 | Values: 178.0 170.0 170.0 171.0 172.0 170.0 172.0 169.0 166.0 169.0 18:17:24 INFO - PROCESS | 1692 | 18:17:24 INFO - PROCESS | 1692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:1.78 (2.6%) stddev-sans-first:1.81 18:17:24 INFO - PROCESS | 1692 | Values: 70.0 72.0 68.0 67.0 68.0 71.0 67.0 67.0 68.0 68.0 18:17:24 INFO - PROCESS | 1692 | -------- Summary: end -------- 18:17:24 INFO - PROCESS | 1692 | 18:17:25 INFO - TEST-INFO | 1692: exit 0 18:17:25 INFO - TEST-OK | kraken | took 64114ms 18:17:25 INFO - SUITE-END | took 1179s 18:17:25 INFO - Completed test suite (00:19:39) 18:17:25 INFO - javascript benchmark 18:17:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6241.263498872629, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.5539958207105, 2636.9077082302124, 2656.375751698351, 2677.3842016336243, 2680.115561864585, 4596.517365676602, 4601.378813860128, 4666.996595731917, 4684.086603112394, 4689.460712018111, 4663.160631086412, 4724.220503616899, 4751.524847515247, 4772.761361931907, 4809.90380192396, 4348.282533381988, 4388.23205938961, 4436.0906014267, 4471.217536931024, 4514.413126293577, 4448.488423831269, 4476.6418686505, 4500.414946057024, 4525.049739554697, 4551.726896386227, 4303.548127446636, 4335.913281734348, 4380.408644832971, 4385.2106620808245, 4389.824407023715, 4418.8453404130705, 4419.071994881079, 4422.690411671184, 4442.311441726538, 4468.82124715011, 4305.526392096866, 4388.363687265361, 4413.470383553994, 4417.226985277595, 4448.599626033672, 4623.514530974267, 4708.10545996263, 4725.432948046222, 4726.810927562893, 4767.713937163781, 5179.378474583036, 5200.5059519345605, 5207.817726379559, 5210.635255532115, 5215.791368345262, 5092.236164575306, 5114.0, 5162.974185129088, 5239.476052394768, 5256.08018596744, 4831.154547954094, 4835.202191638376, 4835.782389792433, 4839.637027222972, 4883.047805677858, 5307.416184219733, 5310.336207974004, 5318.760655770499, 5320.654157479751, 5321.920171197435, 4906.337644417958, 5049.5707864831165, 5064.41759197697, 5093.719845408464, 5121.1550094234035, 5018.874528136826, 5060.342155519759, 5181.53366197044, 5197.272381866542, 5209.0363282792805, 5122.0, 5169.560587350042, 5178.3785945686, 5180.637355385163, 5235.973820130951, 4879.487653796371, 5043.268726034705, 5064.088464076428, 5116.718580478109, 5143.588512918957, 4365.890852728708, 4365.934510982338, 4366.825326986885, 4368.541303163186, 4416.006398560298, 3790.4314352847296, 3817.4655548223272, 3829.942550861739, 3841.2701586698436, 3856.016715737525, 4392.121575684812, 4413.337999300131, 4457.442819647544, 4468.955310446854, 4472.217361961643, 5123.820666276737, 5162.6902385856965, 5166.535011848951, 5168.457311982263, 5218.0, 4372.169287835365, 4447.799849006802, 4450.888727781831, 4469.374287599739, 4526.569975852289, 4576.153411618861, 4590.127875703605, 4611.953880461219, 4619.861404157813, 4623.260278355447, 4800.567948884547, 4815.927761083586, 4820.662553621213, 4842.661013729005, 4897.3878265216845, 5038.470960549236, 5122.257272695364, 5128.974355128201, 5156.20078887773, 5204.0892843752945, 4843.709377437365, 4855.1260773061185, 4857.587105096107, 4877.512248775094, 4917.803287868445, 5124.333836601218, 5125.2568377585785, 5125.94918041808, 5129.717865517432, 5176.378834539879, 4965.205567109245, 5041.42023667283, 5084.872878178076, 5182.274481572658, 5194.766235519335, 4829.927551086666, 4881.90236195267, 4912.312276281395, 4958.5041495851565, 4963.230699241623, 4963.404391473046, 4979.576735977337, 4981.526754958273, 4985.8504244871265, 5024.84925452237, 4668.486466488752, 4840.903181936271, 4845.878853028703, 4865.343178670834, 4865.878353041202, 5021.171506701354, 5021.397432308, 5072.492750725046, 5076.847694569169, 5089.160288552495, 4886.462489126265, 4886.853394398174, 4895.16782147043, 4898.975505122452, 4967.279744437109], "value": 4708.07722436761, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.7516929458508, 564.5483613109512, 583.0700033446652, 586.9735861886214, 588.088462882532, 39758.801205993965, 40880.79559602201, 40974.0, 41009.58990410099, 44765.7761711191, 37618.247635047286, 37893.431598525975, 38007.23985520288, 38150.42774358387, 38283.808580957055, 7533.246675332478, 7674.117476490219, 7697.99926009618, 7748.7675369739, 7762.495437796553, 7564.546127232356, 7654.349380302681, 7664.885026724603, 7665.1951545087795, 7670.27132422419, 7699.961500192491, 7724.575148366837, 7735.419843511759, 7749.845003099935, 7767.485340358632, 7701.884471732928, 7707.190744971781, 7726.7681969541, 7747.767566973, 7754.844903101906, 7702.537847729154, 7747.418943579254, 7753.147153813076, 7759.107702614158, 7761.689532418753, 37671.81164094162, 38228.23543529142, 38228.61771382279, 38231.8088409559, 38277.617223827685, 2998.190488568074, 3002.219422950027, 3137.984310078435, 3155.195425166568, 3336.7831090979007, 28516.857415712995, 28628.0, 28970.56544151818, 29017.56473652897, 29646.703532964824, 3059.2351912021995, 3111.1599868035505, 3143.182772479149, 3150.70068343507, 3168.429682657121, 248712.0, 249058.0, 250873.0, 251947.74026129936, 252962.0, 32456.83771581127, 52578.63396147182, 52833.0, 52986.20520692193, 53009.734951324994, 31674.208144796103, 33364.332713346084, 33648.327033459194, 33837.96972181677, 33865.32269354599, 13836.792448113287, 14153.504627337994, 14210.85789142116, 14245.14529128235, 14264.286785660675, 11698.35659038761, 11833.112516561292, 11855.940720296516, 11860.703482413008, 11904.642860714192, 7893.842123157505, 7908.802279943047, 7950.562719050507, 8003.0, 8018.799530011796, 3117.0804612639326, 3117.267442151093, 3118.251619611277, 3136.153238625604, 3165.4776961801504, 885.6103314541581, 903.4850135422746, 923.5566927874657, 982.8967958364269, 1025.707673313102, 27424.862875685492, 28340.149795506168, 28573.0, 28734.856325718654, 28857.42285154285, 1003.8193125237527, 1016.3190662256306, 1031.6183012285503, 1031.7369070886875, 1107.4739498738195, 14692.41230350774, 15203.467878624195, 15245.0, 15367.15480648575, 15396.538103856903, 386274.0, 394269.0, 400385.0, 401839.0, 402721.0, 49927.50072499301, 50169.24746128811, 50474.0, 50504.242436363485, 50525.49474505208, 1210.3948025987006, 1224.2837939805136, 1245.7944439167618, 1248.2260998181187, 1252.9812052819216, 26864.776226852904, 27681.584776228774, 27967.160985170478, 28235.57646635261, 28501.0, 43254.56745432506, 43296.350554741075, 43303.566964329955, 43745.0, 43797.34303985379, 344062.0, 347137.0, 348105.0, 348592.0, 349621.0, 24733.381665458506, 24991.375215619755, 25094.62358064594, 26699.733002670502, 27590.172294831187, 42175.78912105542, 42657.5734242666, 42734.14531709411, 42798.0, 43185.78407107944, 35988.82005589955, 36317.27365452623, 36440.0, 36577.45133822942, 36715.63284367122, 35950.28099438049, 36046.0, 36094.278114438086, 36148.09629759277, 36190.63809361978, 34838.47742283918, 36175.095622609646, 36313.63686363103, 36331.09172270714, 37249.0, 31296.0, 32653.673463265062, 33115.66884331126, 33396.66603333935, 33542.664573353955, 24801.775769149895, 25237.583422900552, 25868.482630346913, 26804.59793103144, 27424.45151097007], "value": 16622.45947918472, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.791394947905, 373.60957799099936, 376.74946160803063, 383.1933779394375, 387.2931899283808, 15802.209889505522, 16370.345186192553, 17226.655466890672, 17329.353711397427, 17403.91298043508, 15767.369305227778, 15853.603659908507, 16475.0, 16581.336746530156, 16685.24916378763, 5015.272785446117, 5130.410002849682, 5151.381834179903, 5205.0, 5212.6611770235, 3706.8887933362043, 5147.253648221005, 5822.7088645567765, 6121.632702037892, 6180.165677633529, 6075.817725468243, 6104.572679912408, 6111.602745821508, 6126.111713801496, 6158.907616385758, 4998.200287953928, 5307.336582927153, 5317.282166907476, 5352.678839269617, 5379.462053794589, 5049.2173713074535, 5184.870378240536, 5280.128778751501, 5280.815171469018, 5338.0925242708445, 11891.762164756743, 12104.092193085553, 12114.939425302906, 12279.0, 12299.508019679202, 1752.535578071812, 1794.596215851436, 1819.8362147406665, 1845.2342277954633, 1873.3536929759211, 8748.781280467976, 9089.909100908972, 9239.953800230956, 10066.798664026752, 13474.797878031837, 1612.733898906679, 1758.103367282695, 1783.0995347349635, 1820.417466410749, 1825.954351141219, 52521.737391312796, 66563.33436665668, 67396.0, 68009.65995170042, 68411.0, 9521.285903557122, 9727.124558789601, 9904.55429505674, 10016.29885907994, 10053.59785608582, 13489.865101349058, 13506.392212350467, 13563.59309220725, 13645.249511276777, 13719.588412347646, 7450.515716478411, 7513.586752728653, 7523.924760752432, 7581.772546823494, 7602.847943041219, 7218.242084581148, 7272.454565907578, 7370.705171793175, 7448.925510744932, 7460.29127232912, 4250.055882572101, 4275.209086319041, 4342.457192850894, 4351.151525452507, 4435.800388982503, 1605.662810809743, 1721.6556688662317, 1817.354839032151, 1821.8087100854484, 1827.3695575026595, 783.2519943454101, 860.4020205956925, 862.5169904853302, 923.7275003873873, 997.3666721631816, 16233.431829885898, 16417.58956026109, 16428.507144785675, 16691.0, 16746.162691865356, 829.4359835311925, 829.4898637337993, 859.3254295378098, 890.4212262029732, 924.8196601662746, 8790.604422800989, 8974.41666291689, 9045.366824322366, 9171.0, 9314.161725444743, 382180.0, 400004.0, 406652.0, 409666.0, 412137.0, 78786.6060669693, 79413.60293198613, 79550.0, 81759.59120204361, 81777.59111204406, 929.702495201529, 953.8903026151943, 956.5217391304348, 956.5408603870181, 956.8469044952774, 14461.349239284467, 14502.709945801236, 14583.125012499284, 14589.562313130624, 14700.926495367456, 33729.0, 33848.0, 34187.17980757216, 34405.311893761485, 34554.65445345514, 45220.54779452295, 46188.53811461842, 48490.5150948486, 49554.25668615046, 50187.494375168804, 7285.927140728525, 7865.685372585262, 7899.447038707235, 7930.881036784337, 8051.315638170821, 8610.052894181761, 11491.310521368745, 11934.164608477324, 11988.76022479528, 12049.33728644933, 10298.536565854405, 10337.896621033693, 10500.26498145153, 10567.0, 10760.40817755031, 10441.0, 10486.580536778443, 10492.265541412027, 10531.894681053398, 10687.572497100029, 10561.841572376574, 10648.627298044532, 10659.09397701204, 10688.770791359093, 10906.34561926287, 6511.674416279072, 7858.5677787722225, 7875.212478752079, 7885.960570197112, 7892.4080693947035, 8733.825323493367, 10812.0, 10994.560217591206, 11013.504392302206, 11082.61210857616], "value": 8088.871954749814, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1176.2119380015388, 1187.0681515010715, 1302.3488255872064, 1386.9375878085484, 1387.084524214019, 6431.485481161508, 7252.8549429011455, 7437.665305061271, 7635.885461718079, 7728.304452599265, 7337.743178988737, 7567.091948966118, 7575.0, 7585.544867307952, 7585.696572137108, 2147.3235930681826, 2175.9456013599706, 2184.290105715641, 2186.5954798362354, 2187.7593464718866, 2087.5824835032977, 2124.60694771467, 2169.381726208031, 2180.411288951982, 2182.978170218293, 2131.7015617813518, 2136.8931553422344, 2141.8072373486384, 2146.0557354763932, 2188.9890550547225, 2075.0765909170427, 2092.73840769903, 2093.2464312847364, 2095.476130967258, 2099.4751312171957, 2075.533005073861, 2105.9157633694635, 2114.851960362775, 2122.2466024561368, 2127.1066152215953, 7549.886751698729, 7623.923760762377, 7679.2704693054075, 7693.346065584432, 7713.65288562016, 4354.499232588261, 4454.799534020977, 4458.554144585548, 4464.397306363664, 4473.753943533105, 2696.245051385615, 2785.9860700696568, 2787.860606969664, 2849.1594979480897, 2854.100958198161, 874.9168828961302, 881.1981097201516, 906.0441234497603, 922.1562270522531, 926.56914534741, 10153.64462243818, 10161.745956351077, 10164.59341626334, 10165.59337626494, 10173.745656358577, 4037.4953130858644, 4114.753114813121, 4164.979175104105, 4177.874663760092, 4193.161367726467, 8794.736157915273, 8839.779005524913, 8856.247218986458, 8906.73279801607, 8914.643414263357, 4481.3726078349055, 4517.0, 4572.702774319659, 4579.358889755437, 4582.312653102062, 3502.772319799205, 4056.553779084298, 4140.91718165635, 4141.855035073758, 4183.623473887304, 3638.399664055454, 3645.2709458108484, 3700.9814950925074, 3753.3806921857586, 3850.114473671071, 1117.3519358771894, 1145.3013661666378, 1146.2148428326623, 1157.5543415784985, 1161.936093514848, 683.7606837606797, 794.7337641890032, 799.6441583495289, 827.1893544326473, 839.6053854688287, 4898.706077635354, 5146.2280657900865, 5165.199394093921, 5178.508041736104, 5203.2195170723935, 386.77567011133476, 387.30285486124865, 396.6806720589895, 396.7222943939254, 403.4311620614919, 3508.210652603144, 3610.4403817408343, 3610.891673249807, 3624.3838547447, 3646.34365814156, 8974.326925480615, 9430.669926552539, 9438.716838494856, 9443.716688499357, 9449.291303152291, 8911.866322005175, 9366.29752768545, 9369.765755856022, 9376.5311734413, 9401.0, 6979.371856532936, 7242.311980361857, 7256.96371518139, 7297.708091676273, 7298.744543940937, 4906.533879281463, 4925.581325587365, 5176.50823171798, 5374.785008599612, 5435.429279925551, 8616.0, 8750.256228220673, 8760.4305720128, 8825.867611985954, 8882.15619516145, 8270.958645206736, 8584.871226931726, 8644.438111522732, 8756.605952732016, 8834.116588341114, 5705.258316418839, 6477.4494167996245, 6503.284638689645, 6687.598744075371, 6750.45996320303, 7337.59643219628, 7399.371053460516, 7415.592142432218, 7457.216992215739, 7467.738629147953, 6732.192136943598, 6787.626680532618, 6904.585724856524, 6911.619860907497, 6918.827029324307, 6530.67346632676, 6590.7693230736695, 6618.437432818265, 6710.228323742636, 6818.829529261808, 6262.624242545462, 6293.244810622755, 6326.462250708557, 6343.429091381798, 6345.746170153142, 4608.815647374067, 4662.0, 4666.0, 4745.928811067905, 4763.642726795435, 4502.797374118238, 4515.571020753023, 4579.656525760514, 4590.472095709036, 4636.258198688193], "value": 3957.265442630392, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.1465068168789, 292.7716381222646, 298.54173843150767, 300.4456777245981, 302.7320821073352, 4833.250846118857, 4983.576396006335, 5012.7744251508675, 5066.797328106876, 5080.364954380702, 4975.800967961277, 4981.227909673998, 5002.274670172823, 5010.423801262847, 5018.473060328668, 3908.335582950891, 3924.489816323874, 3940.428637847525, 3948.8223029963647, 3950.6444420002194, 3645.3985092459843, 3935.311320518912, 3940.074082590603, 3941.3052387473376, 3966.266240745457, 3815.2831225948294, 3830.0, 3834.0, 3841.519810023747, 3842.442845787359, 3819.3888977763563, 3837.079101015764, 3840.9807950960344, 3857.9228415431535, 3895.61043895611, 3387.2548039431285, 3393.06690660068, 3397.403220486392, 3426.5202871597994, 3428.142964258935, 4648.651351148677, 4818.975905120452, 4848.163824162869, 4857.878553036167, 4878.804847806119, 4387.319965405367, 4397.31841564558, 4418.624416924533, 4422.380866678667, 4436.778161091965, 5256.9474305256845, 5265.447128051538, 5278.261043453919, 5278.392984806719, 5298.788048478056, 3611.3138503684218, 3685.94471082934, 3689.5572531296416, 3690.0774806298427, 3702.777833330009, 5409.6213265071465, 5485.588580856412, 5503.147012213113, 5542.168674698787, 5557.888842223173, 3714.6998550507647, 3716.851325946986, 3726.496922915426, 3738.345789486829, 3771.9434208486896, 3790.639889210521, 3794.6964242860504, 3812.866549670748, 3816.7709937403843, 3829.195868867569, 4309.806058727365, 4342.478902531717, 4362.367456718758, 4370.169667763115, 4373.972116552608, 5205.375354957429, 5229.816956406507, 5238.214267859851, 5240.895182096413, 5270.60470464709, 1235.7837378458735, 1265.702559898423, 1303.5567906911695, 1306.6933066933068, 1311.7966715159166, 794.1899262751961, 804.4368941740805, 827.9981222720455, 835.4694768821842, 837.1586555511672, 4171.416001759756, 4207.915841683149, 4244.580589064204, 4255.829766809355, 4257.19113368459, 4727.503612120678, 4755.310479980452, 4849.393825771778, 4877.780499877443, 4887.926681099786, 4230.365445183247, 4232.576742325743, 4247.787610619456, 4266.786660666954, 4267.0, 2514.597664373728, 2546.185220729386, 2577.718718933757, 2596.9220923372327, 2637.720705457851, 4479.0, 4523.705959112647, 4535.365048893158, 4535.614472769786, 4535.614472769786, 4852.519981405705, 4861.961274203622, 4878.243872199815, 4895.461499235082, 4941.196463290945, 4270.893227669333, 4427.867163985085, 4504.851262927932, 4525.434320709977, 4532.410786597721, 4759.762011899322, 4808.495108013748, 4809.254565542346, 4821.63837712166, 4836.419629644324, 4680.742559159279, 4692.718436893797, 4694.201985662377, 4705.011947491065, 4719.952800471951, 4497.572730590588, 4752.334673145693, 5217.4260831307765, 5219.634625576173, 5225.764840582106, 3790.2608991246443, 3791.0, 3798.1454172810895, 3799.582045974885, 3799.7530160539477, 5253.343332083489, 5457.69982650958, 5533.806316779054, 5538.750756215899, 5540.833774986757, 5122.7449274927885, 5236.816711415082, 5264.894702106013, 5291.417944026077, 5313.203019547099, 5283.471652834686, 5306.469353064663, 5310.628256022042, 5312.0, 5343.679379237103, 4898.853034408973, 5110.872228194176, 5165.509276618715, 5177.119889618699, 5178.637495375438, 5312.442193569619, 5327.6270661054905, 5328.786848526015, 5333.466653334635, 5335.893282134413, 5185.429602743619, 5208.270842082187, 5214.582833373245, 5249.448807875118, 5251.186066159751], "value": 3818.805827364198, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.6463875322828, 631.8136149835798, 658.4403257231353, 669.83923858274, 725.9927400725991, 12780.936095319523, 13363.465461381533, 13453.59639210824, 13510.797338039913, 13521.053526253167, 13463.596092117228, 13475.932620336884, 13479.39342729577, 13507.93246033771, 13527.729445411085, 628.2241431831684, 769.7152053740124, 779.2752739951843, 781.03932163439, 782.5930516131608, 765.4412279036306, 775.5540564175593, 777.7472321495509, 778.0857492446381, 783.5142211828675, 819.3608984991716, 828.362161135925, 828.5153185386556, 828.8756686497044, 829.4940086547201, 817.7710241132493, 821.9013718353776, 823.0945959444623, 823.217942954193, 823.8146417056114, 596.764278110144, 597.011945230644, 597.0894386061248, 599.811059516251, 601.7923816283375, 12634.2419454833, 12688.365581720876, 12689.555865544662, 12724.681882952907, 12798.616041518677, 12462.43919023646, 12583.0, 12823.35883205836, 12928.543576720393, 13044.369044109208, 9290.907090929071, 9930.0, 10120.696379108565, 10159.23805714567, 10203.03071208234, 3192.712655860984, 3255.690709382605, 3298.1259966109, 3327.9516952159993, 3381.3744457275484, 55584.0, 55732.16401753977, 55868.44131558714, 56238.718806405705, 56315.0, 9307.72076837696, 9558.474283914451, 9657.372270802376, 9800.509974501247, 9854.408735475894, 17937.372191973478, 18030.36893708714, 18061.367852125375, 18075.54811129732, 18107.18517666708, 6249.250089989139, 6468.967655161694, 6478.125453063871, 6602.2407423146, 6690.598564086073, 3261.641219465904, 3282.950755738666, 3293.4565796643765, 3316.701496865294, 3334.9166270843425, 2922.678505364408, 3017.230606195406, 3025.9394812104074, 3030.045535656261, 3030.075826872825, 474.5231042801962, 474.83618151737596, 476.6996792021074, 494.88617617948074, 495.79920132346456, 554.6006875049958, 583.7023118209744, 584.8567101060182, 601.3565484931082, 605.6608299352376, 7427.962860185665, 7932.206779322021, 7984.560849153236, 8045.0, 8125.837483250302, 452.4412350746825, 536.7235873525137, 564.3145310991692, 580.7096451774113, 587.524105474567, 3684.9447258291148, 3707.962920370816, 3722.590515043343, 3789.2800367930004, 3813.122981714221, 73721.0, 88187.55906220428, 92395.0, 92494.0, 92704.0, 49765.751171244636, 49793.00413991772, 50341.74829125831, 64366.0, 81867.0, 47310.0, 72523.0, 72870.0, 73017.6349118251, 73269.0, 7081.539699919489, 7204.063471748639, 7208.06295181623, 7215.134183897756, 7269.927300727137, 42637.36043959281, 42712.572874272104, 43296.350554742334, 43337.56662433461, 43347.349789752545, 56589.43410566006, 59398.0, 59846.401535984085, 59931.40754517087, 60056.699716501134, 9259.72220833376, 9312.767180820534, 9339.906600933904, 9375.24998000172, 9443.763905902408, 10313.329633573794, 10479.109275711346, 10618.52216650268, 10629.415382154055, 10847.24069315172, 10396.792064158826, 10407.427591482237, 10456.581736730446, 10560.471976401303, 10928.125749940145, 9739.756506087404, 9890.159336456481, 10109.64616238428, 10142.0, 10581.4709264538, 10223.386596804216, 10564.683059508227, 10680.732981675521, 10762.51568679427, 10973.122150228122, 9464.479453629841, 9792.167665748491, 9860.605575776888, 9879.604815807288, 10265.12746416533, 9531.142197202285, 9560.139587437165, 9640.0, 9863.901360986298, 9894.109530142034], "value": 6177.848005211696, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 118.0, 115.0, 117.0, 118.0, 117.0, 116.0, 115.0, 115.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 132.0, 157.0, 182.0, 135.0, 161.0, 155.0, 134.0, 201.0, 136.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 166.0, 176.0, 163.0, 165.0, 164.0, 164.0, 161.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 161.0, 79.0, 76.0, 77.0, 75.0, 156.0, 78.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 149.0, 86.0, 86.0, 88.0, 132.0, 90.0, 85.0, 142.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 147.0, 147.0, 148.0, 150.0, 147.0, 148.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 64.0, 62.0, 63.0, 63.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 69.0, 64.0, 65.0, 66.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 86.0, 86.0, 85.0, 86.0, 86.0, 89.0, 115.0, 89.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 132.0, 136.0, 132.0, 137.0, 148.0, 132.0, 136.0, 138.0, 136.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 170.0, 170.0, 171.0, 172.0, 170.0, 172.0, 169.0, 166.0, 169.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 68.0, 67.0, 68.0, 71.0, 67.0, 67.0, 68.0, 68.0], "value": 68.6, "unit": "score"}]}]} 18:17:25 INFO - Return code: 0 18:17:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:17:25 ERROR - # TBPL SUCCESS # 18:17:25 INFO - Running post-action listener: _resource_record_post_action 18:17:25 INFO - ##### 18:17:25 INFO - ##### Finished run-tests step (success) 18:17:25 INFO - ##### 18:17:25 INFO - Running post-run listener: _resource_record_post_run 18:17:25 INFO - Total resource usage - Wall time: 1196s; CPU: 14.0%; Read bytes: 8192; Write bytes: 523702272; Read time: 20; Write time: 399600 18:17:25 INFO - TinderboxPrint: CPU usage
13.5% 18:17:25 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 18:17:25 INFO - TinderboxPrint: I/O write bytes / time
523,702,272 / 399,600 18:17:25 INFO - TinderboxPrint: CPU idle
8,253.6 (86.5%) 18:17:25 INFO - TinderboxPrint: CPU user
1,235.6 (12.9%) 18:17:25 INFO - TinderboxPrint: Swap in / out
0 / 0 18:17:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 222101504; Read time: 0; Write time: 160816 18:17:25 INFO - run-tests - Wall time: 1181s; CPU: 14.0%; Read bytes: 8192; Write bytes: 285667328; Read time: 20; Write time: 237024 18:17:26 INFO - Running post-run listener: _upload_blobber_files 18:17:26 INFO - Blob upload gear active. 18:17:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:17:26 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 18:17:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:17:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:17:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:17:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:18:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:12 INFO - (blobuploader) - INFO - Done attempting. 18:18:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:18:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:18:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:58 INFO - (blobuploader) - INFO - Done attempting. 18:18:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:18:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:19:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:28 INFO - (blobuploader) - INFO - Done attempting. 18:19:28 INFO - (blobuploader) - INFO - Iteration through files over. 18:19:28 INFO - Return code: 0 18:19:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:19:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:19:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0f112c2f2013f42b2b907c0efdebc92dac0d3f5b70fa0cbfe357dd8382206aaa6b587919bae074940583d52fb18e305f19e4cf87bc274c36ba4d4a45061fdf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5922240035eb199d2fe38f95f9b4ac71d0787ead40418e3fc6728f238ebc829e8629303c3da0bb385f29c68858bd79f5af393dee4ab71fea8030ce8b220dd24e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55db9eb892151eb30fa45e4ddf8014dbe6762810829ff350c8fc2b269f7a76a186919f2c3fca49f9105e5cb80c4263846632800a6cd74652f250ae7adb5a8cce"} 18:19:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:19:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:19:28 INFO - Contents: 18:19:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0f112c2f2013f42b2b907c0efdebc92dac0d3f5b70fa0cbfe357dd8382206aaa6b587919bae074940583d52fb18e305f19e4cf87bc274c36ba4d4a45061fdf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5922240035eb199d2fe38f95f9b4ac71d0787ead40418e3fc6728f238ebc829e8629303c3da0bb385f29c68858bd79f5af393dee4ab71fea8030ce8b220dd24e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55db9eb892151eb30fa45e4ddf8014dbe6762810829ff350c8fc2b269f7a76a186919f2c3fca49f9105e5cb80c4263846632800a6cd74652f250ae7adb5a8cce"} 18:19:28 INFO - Running post-run listener: copy_logs_to_upload_dir 18:19:28 INFO - Copying logs to upload dir... 18:19:28 INFO - mkdir: /builds/slave/test/build/upload/logs 18:19:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1355.771493 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 35 secs) (at 2016-06-07 18:19:28.323387) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 18:19:28.327018) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0f112c2f2013f42b2b907c0efdebc92dac0d3f5b70fa0cbfe357dd8382206aaa6b587919bae074940583d52fb18e305f19e4cf87bc274c36ba4d4a45061fdf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5922240035eb199d2fe38f95f9b4ac71d0787ead40418e3fc6728f238ebc829e8629303c3da0bb385f29c68858bd79f5af393dee4ab71fea8030ce8b220dd24e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55db9eb892151eb30fa45e4ddf8014dbe6762810829ff350c8fc2b269f7a76a186919f2c3fca49f9105e5cb80c4263846632800a6cd74652f250ae7adb5a8cce"} build_url:https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011416 build_url: 'https://queue.taskcluster.net/v1/task/d_CQ7dNMQQqK13bQ4ftM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0f112c2f2013f42b2b907c0efdebc92dac0d3f5b70fa0cbfe357dd8382206aaa6b587919bae074940583d52fb18e305f19e4cf87bc274c36ba4d4a45061fdf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5922240035eb199d2fe38f95f9b4ac71d0787ead40418e3fc6728f238ebc829e8629303c3da0bb385f29c68858bd79f5af393dee4ab71fea8030ce8b220dd24e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55db9eb892151eb30fa45e4ddf8014dbe6762810829ff350c8fc2b269f7a76a186919f2c3fca49f9105e5cb80c4263846632800a6cd74652f250ae7adb5a8cce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 18:19:28.352784) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 18:19:28.353172) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465347411.434105-525193882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 18:19:28.438771) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 18:19:28.439264) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 18:19:28.439569) ========= ========= Total master_lag: 0.17 =========