builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1464041140.93 results: success (0) buildid: 20160523144654 builduid: e92648406c49408d84939f75e67c7e00 revision: c90fe6f633f400db7eb108f02397bcc391c12a0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:40.928542) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:40.928993) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:40.929266) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:40.945800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:40.946139) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 15:05:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-05-23 15:05:42 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088890 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:41.049068) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:41.049378) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016567 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:41.098725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:41.099065) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c90fe6f633f400db7eb108f02397bcc391c12a0d --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 c90fe6f633f400db7eb108f02397bcc391c12a0d --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=97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 15:05:42,382 truncating revision to first 12 chars 2016-05-23 15:05:42,382 Setting DEBUG logging. 2016-05-23 15:05:42,382 attempt 1/10 2016-05-23 15:05:42,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c90fe6f633f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 15:05:42,935 unpacking tar archive at: fx-team-c90fe6f633f4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.819904 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:41.932202) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:41.932560) ========= script_repo_revision: c90fe6f633f400db7eb108f02397bcc391c12a0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:41.933004) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:41.933308) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 15:05:41.941688) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-23 15:05:41.942014) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:05:43 INFO - MultiFileLogger online at 20160523 15:05:43 in /builds/slave/test 15:05:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 15:05:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:43 INFO - {'append_to_log': False, 15:05:43 INFO - 'base_work_dir': '/builds/slave/test', 15:05:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:05:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:43 INFO - 'branch': 'Fx-Team-Non-PGO', 15:05:43 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:43 INFO - 'config_files': ('talos/linux_config.py',), 15:05:43 INFO - 'default_actions': ('clobber', 15:05:43 INFO - 'read-buildbot-config', 15:05:43 INFO - 'download-and-extract', 15:05:43 INFO - 'populate-webroot', 15:05:43 INFO - 'create-virtualenv', 15:05:43 INFO - 'install', 15:05:43 INFO - 'run-tests'), 15:05:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:43 INFO - 'download_minidump_stackwalk': True, 15:05:43 INFO - 'download_symbols': 'ondemand', 15:05:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:43 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:43 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:43 INFO - 'installer_path': 'installer.exe', 15:05:43 INFO - 'log_level': 'info', 15:05:43 INFO - 'log_name': 'talos', 15:05:43 INFO - 'log_to_console': True, 15:05:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:05:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:05:43 INFO - 'opt_config_files': (), 15:05:43 INFO - 'pip_index': False, 15:05:43 INFO - 'sps_profile': False, 15:05:43 INFO - 'sps_profile_interval': 0, 15:05:43 INFO - 'suite': 'dromaeojs', 15:05:43 INFO - 'system_bits': '32', 15:05:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:43 INFO - 'title': 'talos-linux64-ix-068', 15:05:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:43 INFO - 'use_talos_json': True, 15:05:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:43 INFO - 'work_dir': 'build'} 15:05:43 INFO - ##### 15:05:43 INFO - ##### Running clobber step. 15:05:43 INFO - ##### 15:05:43 INFO - Running pre-action listener: _resource_record_pre_action 15:05:43 INFO - Running main action method: clobber 15:05:43 INFO - rmtree: /builds/slave/test/build 15:05:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:43 INFO - Running post-action listener: _resource_record_post_action 15:05:43 INFO - ##### 15:05:43 INFO - ##### Finished clobber step (success) 15:05:43 INFO - ##### 15:05:43 INFO - ##### 15:05:43 INFO - ##### Running read-buildbot-config step. 15:05:43 INFO - ##### 15:05:43 INFO - Running pre-action listener: _resource_record_pre_action 15:05:43 INFO - Running main action method: read_buildbot_config 15:05:43 INFO - Using buildbot properties: 15:05:43 INFO - { 15:05:43 INFO - "project": "", 15:05:43 INFO - "product": "firefox", 15:05:43 INFO - "script_repo_revision": "production", 15:05:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:05:43 INFO - "repository": "", 15:05:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:05:43 INFO - "buildid": "20160523144654", 15:05:43 INFO - "pgo_build": "False", 15:05:43 INFO - "basedir": "/builds/slave/test", 15:05:43 INFO - "buildnumber": 3000, 15:05:43 INFO - "slavename": "talos-linux64-ix-068", 15:05:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:05:43 INFO - "platform": "ubuntu64_hw", 15:05:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:05:43 INFO - "branch": "fx-team", 15:05:43 INFO - "repo_path": "integration/fx-team", 15:05:43 INFO - "revision": "c90fe6f633f400db7eb108f02397bcc391c12a0d", 15:05:43 INFO - "stage_platform": "linux64", 15:05:43 INFO - "builduid": "e92648406c49408d84939f75e67c7e00", 15:05:43 INFO - "slavebuilddir": "test" 15:05:43 INFO - } 15:05:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:05:43 INFO - Running post-action listener: _resource_record_post_action 15:05:43 INFO - ##### 15:05:43 INFO - ##### Finished read-buildbot-config step (success) 15:05:43 INFO - ##### 15:05:43 INFO - ##### 15:05:43 INFO - ##### Running download-and-extract step. 15:05:43 INFO - ##### 15:05:43 INFO - Running pre-action listener: _resource_record_pre_action 15:05:43 INFO - Running main action method: download_and_extract 15:05:43 INFO - mkdir: /builds/slave/test/build/tests 15:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:43 INFO - https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:05:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:05:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:05:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:05:44 INFO - Downloaded 1361 bytes. 15:05:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:05:44 INFO - Using the following test package requirements: 15:05:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:05:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:05:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:44 INFO - u'jsshell-linux-x86_64.zip'], 15:05:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:05:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:05:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:05:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:05:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:05:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:05: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')]} 15:05:44 INFO - https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:05:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:05:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:05:45 INFO - Downloaded 22814893 bytes. 15:05:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:05:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:05:46 INFO - Return code: 0 15:05:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:46 INFO - https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:05:47 INFO - Downloaded 22814893 bytes. 15:05:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:05:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:05:49 INFO - Return code: 0 15:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:49 INFO - https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:05:50 INFO - Downloaded 10840359 bytes. 15:05:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:05:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:05:50 INFO - Return code: 0 15:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:50 INFO - https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:05:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:05:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:05:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:05:52 INFO - Downloaded 54812938 bytes. 15:05:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:05:52 INFO - mkdir: /builds/slave/test/properties 15:05:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:05:52 INFO - Writing to file /builds/slave/test/properties/build_url 15:05:52 INFO - Contents: 15:05:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:05:52 INFO - Running post-action listener: _resource_record_post_action 15:05:52 INFO - Running post-action listener: set_extra_try_arguments 15:05:52 INFO - ##### 15:05:52 INFO - ##### Finished download-and-extract step (success) 15:05:52 INFO - ##### 15:05:52 INFO - ##### 15:05:52 INFO - ##### Running populate-webroot step. 15:05:52 INFO - ##### 15:05:52 INFO - Running pre-action listener: _resource_record_pre_action 15:05:52 INFO - Running main action method: populate_webroot 15:05:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:05:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:05:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:05:52 INFO - '--tppagecycles', 15:05:52 INFO - '7'], 15:05:52 INFO - 'tests': ['tsvgm']}}, 15:05:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:05:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:05:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:05:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:05:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:05:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:05:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:52 INFO - 'talos_options': ['--disable-e10s'], 15:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:52 INFO - 'talos_options': ['--disable-e10s'], 15:05:52 INFO - 'tests': ['damp', 'tps']}, 15:05:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:52 INFO - 'tests': ['damp', 'tps']}, 15:05:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:05:52 INFO - 'tests': ['dromaeo_dom']}, 15:05:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:05:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:05:52 INFO - 'tests': ['a11yr', 15:05:52 INFO - 'ts_paint', 15:05:52 INFO - 'tpaint', 15:05:52 INFO - 'sessionrestore', 15:05:52 INFO - 'sessionrestore_no_auto_restore', 15:05:52 INFO - 'tabpaint']}, 15:05:52 INFO - 'other-e10s': {'tests': ['a11yr', 15:05:52 INFO - 'ts_paint', 15:05:52 INFO - 'tpaint', 15:05:52 INFO - 'sessionrestore', 15:05:52 INFO - 'sessionrestore_no_auto_restore', 15:05:52 INFO - 'tabpaint']}, 15:05:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:05:52 INFO - 'ts_paint', 15:05:52 INFO - 'tpaint', 15:05:52 INFO - 'sessionrestore', 15:05:52 INFO - 'sessionrestore_no_auto_restore', 15:05:52 INFO - 'tabpaint']}, 15:05:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:05:52 INFO - 'ts_paint', 15:05:52 INFO - 'tpaint', 15:05:52 INFO - 'sessionrestore', 15:05:52 INFO - 'sessionrestore_no_auto_restore', 15:05:52 INFO - 'tabpaint']}, 15:05:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:05:52 INFO - 'tests': ['a11yr', 15:05:52 INFO - 'ts_paint', 15:05:52 INFO - 'tpaint', 15:05:52 INFO - 'sessionrestore', 15:05:52 INFO - 'sessionrestore_no_auto_restore', 15:05:52 INFO - 'tabpaint']}, 15:05:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:05:52 INFO - 'tests': ['a11yr', 15:05:52 INFO - 'ts_paint', 15:05:52 INFO - 'tpaint', 15:05:52 INFO - 'sessionrestore', 15:05:52 INFO - 'sessionrestore_no_auto_restore', 15:05:52 INFO - 'tabpaint']}, 15:05:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:05:52 INFO - 'tests': ['tsvgx', 15:05:52 INFO - 'tsvgr_opacity', 15:05:52 INFO - 'tart', 15:05:52 INFO - 'tscrollx', 15:05:52 INFO - 'cart']}, 15:05:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:05:52 INFO - 'tsvgr_opacity', 15:05:52 INFO - 'tart', 15:05:52 INFO - 'tscrollx', 15:05:52 INFO - 'cart']}, 15:05:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:52 INFO - 'talos_options': ['--disable-e10s'], 15:05:52 INFO - 'tests': ['tp5o']}, 15:05:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:52 INFO - 'tests': ['tp5o']}, 15:05:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:52 INFO - 'talos_options': ['--disable-e10s', 15:05:52 INFO - '--xperf_path', 15:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:52 INFO - 'tests': ['tp5n']}, 15:05:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:52 INFO - 'talos_options': ['--xperf_path', 15:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:52 INFO - 'tests': ['tp5n']}}, 15:05:52 INFO - 'talos.zip': {'path': '', 15:05:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:05:52 INFO - Running post-action listener: _resource_record_post_action 15:05:52 INFO - ##### 15:05:52 INFO - ##### Finished populate-webroot step (success) 15:05:52 INFO - ##### 15:05:52 INFO - ##### 15:05:52 INFO - ##### Running create-virtualenv step. 15:05:52 INFO - ##### 15:05:52 INFO - Running pre-action listener: _resource_record_pre_action 15:05:52 INFO - Running main action method: create_virtualenv 15:05:52 INFO - Creating virtualenv /builds/slave/test/build/venv 15:05:52 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 15:05:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:05:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:05:53 INFO - Using real prefix '/usr' 15:05:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:05:53 INFO - Installing distribute.............................................................................................................................................................................................done. 15:05:55 INFO - Installing pip.................done. 15:05:55 INFO - Return code: 0 15:05:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9691df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf9c0>, '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 0x15c08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0d50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', '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 15:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:05:55 INFO - Using env: {'DISPLAY': ':0', 15:05:55 INFO - 'HOME': '/home/cltbld', 15:05:55 INFO - 'LANG': 'en_US.UTF-8', 15:05:55 INFO - 'LANGUAGE': 'en_US:en', 15:05:55 INFO - 'LOGNAME': 'cltbld', 15:05:55 INFO - 'MAIL': '/var/mail/cltbld', 15:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:55 INFO - 'MOZ_NO_REMOTE': '1', 15:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:55 INFO - 'NO_EM_RESTART': '1', 15:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:55 INFO - 'PWD': '/builds/slave/test', 15:05:55 INFO - 'SHELL': '/bin/bash', 15:05:55 INFO - 'SHLVL': '1', 15:05:55 INFO - 'TERM': 'linux', 15:05:55 INFO - 'TMOUT': '86400', 15:05:55 INFO - 'USER': 'cltbld', 15:05:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', 15:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:55 INFO - '_': '/tools/buildbot/bin/python'} 15:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:55 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 15:05:55 INFO - Cleaning up... 15:05:55 INFO - Return code: 0 15:05:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8b9691df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf9c0>, '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 0x15c08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0d50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', '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 15:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:05:55 INFO - Using env: {'DISPLAY': ':0', 15:05:55 INFO - 'HOME': '/home/cltbld', 15:05:55 INFO - 'LANG': 'en_US.UTF-8', 15:05:55 INFO - 'LANGUAGE': 'en_US:en', 15:05:55 INFO - 'LOGNAME': 'cltbld', 15:05:55 INFO - 'MAIL': '/var/mail/cltbld', 15:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:55 INFO - 'MOZ_NO_REMOTE': '1', 15:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:55 INFO - 'NO_EM_RESTART': '1', 15:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:55 INFO - 'PWD': '/builds/slave/test', 15:05:55 INFO - 'SHELL': '/bin/bash', 15:05:55 INFO - 'SHLVL': '1', 15:05:55 INFO - 'TERM': 'linux', 15:05:55 INFO - 'TMOUT': '86400', 15:05:55 INFO - 'USER': 'cltbld', 15:05:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', 15:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:55 INFO - '_': '/tools/buildbot/bin/python'} 15:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:56 INFO - Downloading/unpacking psutil>=3.1.1 15:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:05:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:58 INFO - Installing collected packages: psutil 15:05:58 INFO - Running setup.py install for psutil 15:05:58 INFO - building 'psutil._psutil_linux' extension 15:05:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:05:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:05:58 INFO - building 'psutil._psutil_posix' extension 15:05:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:05:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:05:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:58 INFO - Successfully installed psutil 15:05:58 INFO - Cleaning up... 15:05:58 INFO - Return code: 0 15:05:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9691df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf9c0>, '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 0x15c08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0d50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', '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 15:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:05:58 INFO - Using env: {'DISPLAY': ':0', 15:05:58 INFO - 'HOME': '/home/cltbld', 15:05:58 INFO - 'LANG': 'en_US.UTF-8', 15:05:58 INFO - 'LANGUAGE': 'en_US:en', 15:05:58 INFO - 'LOGNAME': 'cltbld', 15:05:58 INFO - 'MAIL': '/var/mail/cltbld', 15:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:58 INFO - 'MOZ_NO_REMOTE': '1', 15:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:58 INFO - 'NO_EM_RESTART': '1', 15:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:58 INFO - 'PWD': '/builds/slave/test', 15:05:58 INFO - 'SHELL': '/bin/bash', 15:05:58 INFO - 'SHLVL': '1', 15:05:58 INFO - 'TERM': 'linux', 15:05:58 INFO - 'TMOUT': '86400', 15:05:58 INFO - 'USER': 'cltbld', 15:05:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', 15:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:58 INFO - '_': '/tools/buildbot/bin/python'} 15:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:06:00 INFO - Installing collected packages: mozsystemmonitor 15:06:00 INFO - Running setup.py install for mozsystemmonitor 15:06:00 INFO - Successfully installed mozsystemmonitor 15:06:00 INFO - Cleaning up... 15:06:00 INFO - Return code: 0 15:06:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:06:00 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')]} 15:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:00 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')]} 15:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:00 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 0x7f8b9691df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf9c0>, '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 0x15c08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0d50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', '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 15:06:00 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 15:06:00 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 15:06:00 INFO - Using env: {'DISPLAY': ':0', 15:06:00 INFO - 'HOME': '/home/cltbld', 15:06:00 INFO - 'LANG': 'en_US.UTF-8', 15:06:00 INFO - 'LANGUAGE': 'en_US:en', 15:06:00 INFO - 'LOGNAME': 'cltbld', 15:06:00 INFO - 'MAIL': '/var/mail/cltbld', 15:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:00 INFO - 'MOZ_NO_REMOTE': '1', 15:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:00 INFO - 'NO_EM_RESTART': '1', 15:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:00 INFO - 'PWD': '/builds/slave/test', 15:06:00 INFO - 'SHELL': '/bin/bash', 15:06:00 INFO - 'SHLVL': '1', 15:06:00 INFO - 'TERM': 'linux', 15:06:00 INFO - 'TMOUT': '86400', 15:06:00 INFO - 'USER': 'cltbld', 15:06:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', 15:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:00 INFO - '_': '/tools/buildbot/bin/python'} 15:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:02 INFO - Downloading blobuploader-1.2.4.tar.gz 15:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:06:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:06:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:03 INFO - Downloading docopt-0.6.1.tar.gz 15:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:06:03 INFO - Installing collected packages: blobuploader, requests, docopt 15:06:03 INFO - Running setup.py install for blobuploader 15:06:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:06:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:06:03 INFO - Running setup.py install for requests 15:06:04 INFO - Running setup.py install for docopt 15:06:04 INFO - Successfully installed blobuploader requests docopt 15:06:04 INFO - Cleaning up... 15:06:04 INFO - Return code: 0 15:06:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:04 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 0x7f8b9691df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf9c0>, '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 0x15c08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0d50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', '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 15:06:04 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 15:06:04 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 15:06:04 INFO - Using env: {'DISPLAY': ':0', 15:06:04 INFO - 'HOME': '/home/cltbld', 15:06:04 INFO - 'LANG': 'en_US.UTF-8', 15:06:04 INFO - 'LANGUAGE': 'en_US:en', 15:06:04 INFO - 'LOGNAME': 'cltbld', 15:06:04 INFO - 'MAIL': '/var/mail/cltbld', 15:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:04 INFO - 'MOZ_NO_REMOTE': '1', 15:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:04 INFO - 'NO_EM_RESTART': '1', 15:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:04 INFO - 'PWD': '/builds/slave/test', 15:06:04 INFO - 'SHELL': '/bin/bash', 15:06:04 INFO - 'SHLVL': '1', 15:06:04 INFO - 'TERM': 'linux', 15:06:04 INFO - 'TMOUT': '86400', 15:06:04 INFO - 'USER': 'cltbld', 15:06:04 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', 15:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:04 INFO - '_': '/tools/buildbot/bin/python'} 15:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:04 INFO - Running setup.py (path:/tmp/pip-vM1fDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:04 INFO - Running setup.py (path:/tmp/pip-zMZHGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:04 INFO - Running setup.py (path:/tmp/pip-w8JtDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:04 INFO - Running setup.py (path:/tmp/pip-t9EIzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:04 INFO - Running setup.py (path:/tmp/pip-3FtWWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:04 INFO - Running setup.py (path:/tmp/pip-9PCGLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:05 INFO - Running setup.py (path:/tmp/pip-t2Z2kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:05 INFO - Running setup.py (path:/tmp/pip-hSR4ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:05 INFO - Running setup.py (path:/tmp/pip-YAvICu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:05 INFO - Running setup.py (path:/tmp/pip-4q93b1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:05 INFO - Running setup.py (path:/tmp/pip-VniF5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:05 INFO - Running setup.py (path:/tmp/pip-zY1XOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:05 INFO - Running setup.py (path:/tmp/pip-gdGn0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:05 INFO - Running setup.py (path:/tmp/pip-myvNgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:05 INFO - Running setup.py (path:/tmp/pip-U3Tti8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:05 INFO - Running setup.py (path:/tmp/pip-DOQGD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:05 INFO - Running setup.py (path:/tmp/pip-SaFLHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:06:05 INFO - Running setup.py install for manifestparser 15:06:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:06:05 INFO - Running setup.py install for mozcrash 15:06:06 INFO - Running setup.py install for mozdebug 15:06:06 INFO - Running setup.py install for mozdevice 15:06:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Running setup.py install for mozfile 15:06:06 INFO - Running setup.py install for mozhttpd 15:06:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Running setup.py install for mozinfo 15:06:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Running setup.py install for mozInstall 15:06:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Running setup.py install for mozleak 15:06:06 INFO - Running setup.py install for mozlog 15:06:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Running setup.py install for moznetwork 15:06:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Running setup.py install for mozprocess 15:06:07 INFO - Running setup.py install for mozprofile 15:06:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:06:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:06:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:06:07 INFO - Running setup.py install for mozrunner 15:06:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:06:07 INFO - Running setup.py install for mozscreenshot 15:06:07 INFO - Running setup.py install for moztest 15:06:07 INFO - Running setup.py install for mozversion 15:06:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:06:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:06:07 INFO - Cleaning up... 15:06:07 INFO - Return code: 0 15:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06: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')]} 15:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06: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')]} 15:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:07 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 0x7f8b9691df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf9c0>, '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 0x15c08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0d50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', '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 15:06:07 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 15:06:07 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 15:06:07 INFO - Using env: {'DISPLAY': ':0', 15:06:07 INFO - 'HOME': '/home/cltbld', 15:06:07 INFO - 'LANG': 'en_US.UTF-8', 15:06:07 INFO - 'LANGUAGE': 'en_US:en', 15:06:07 INFO - 'LOGNAME': 'cltbld', 15:06:07 INFO - 'MAIL': '/var/mail/cltbld', 15:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:07 INFO - 'MOZ_NO_REMOTE': '1', 15:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:07 INFO - 'NO_EM_RESTART': '1', 15:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:07 INFO - 'PWD': '/builds/slave/test', 15:06:07 INFO - 'SHELL': '/bin/bash', 15:06:07 INFO - 'SHLVL': '1', 15:06:07 INFO - 'TERM': 'linux', 15:06:07 INFO - 'TMOUT': '86400', 15:06:07 INFO - 'USER': 'cltbld', 15:06:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', 15:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:07 INFO - '_': '/tools/buildbot/bin/python'} 15:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:07 INFO - Running setup.py (path:/tmp/pip-VX9W3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:07 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)) 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:07 INFO - Running setup.py (path:/tmp/pip-GwT4_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:08 INFO - Running setup.py (path:/tmp/pip-joz4_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:08 INFO - Running setup.py (path:/tmp/pip-zg9nf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:08 INFO - Running setup.py (path:/tmp/pip-InkMwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:08 INFO - Running setup.py (path:/tmp/pip-RR4UNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:08 INFO - Running setup.py (path:/tmp/pip-WQy3Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:08 INFO - Running setup.py (path:/tmp/pip-QnnkiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:08 INFO - Running setup.py (path:/tmp/pip-Bm7RYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:08 INFO - Running setup.py (path:/tmp/pip-aDOeWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:08 INFO - Running setup.py (path:/tmp/pip-4yMA31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:08 INFO - Running setup.py (path:/tmp/pip-lKz7OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:08 INFO - Running setup.py (path:/tmp/pip-1dCFPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:08 INFO - Running setup.py (path:/tmp/pip-cc0pfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:08 INFO - Running setup.py (path:/tmp/pip-X_w5SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:08 INFO - Running setup.py (path:/tmp/pip-6e4chA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:09 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)) 15:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:09 INFO - Running setup.py (path:/tmp/pip-ZuUcuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:09 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)) 15:06:09 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)) 15:06:09 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)) 15:06:09 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)) 15:06:09 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)) 15:06:09 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)) 15:06:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:10 INFO - Downloading blessings-1.6.tar.gz 15:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:06:11 INFO - Installing collected packages: blessings 15:06:11 INFO - Running setup.py install for blessings 15:06:11 INFO - Successfully installed blessings 15:06:11 INFO - Cleaning up... 15:06:11 INFO - Return code: 0 15:06:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:11 INFO - Reading from file tmpfile_stdout 15:06:11 INFO - Current package versions: 15:06:11 INFO - argparse == 1.2.1 15:06:11 INFO - blessings == 1.6 15:06:11 INFO - blobuploader == 1.2.4 15:06:11 INFO - docopt == 0.6.1 15:06:11 INFO - manifestparser == 1.1 15:06:11 INFO - mozInstall == 1.12 15:06:11 INFO - mozcrash == 0.17 15:06:11 INFO - mozdebug == 0.1 15:06:11 INFO - mozdevice == 0.48 15:06:11 INFO - mozfile == 1.2 15:06:11 INFO - mozhttpd == 0.7 15:06:11 INFO - mozinfo == 0.9 15:06:11 INFO - mozleak == 0.1 15:06:11 INFO - mozlog == 3.2 15:06:11 INFO - moznetwork == 0.27 15:06:11 INFO - mozprocess == 0.22 15:06:11 INFO - mozprofile == 0.28 15:06:11 INFO - mozrunner == 6.11 15:06:11 INFO - mozscreenshot == 0.1 15:06:11 INFO - mozsystemmonitor == 0.3 15:06:11 INFO - moztest == 0.7 15:06:11 INFO - mozversion == 1.4 15:06:11 INFO - psutil == 3.1.1 15:06:11 INFO - requests == 1.2.3 15:06:11 INFO - wsgiref == 0.1.2 15:06:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:11 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')]} 15:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:11 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')]} 15:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:11 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 0x7f8b9691df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf9c0>, '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 0x15c08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0d50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', '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 15:06:11 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 15:06:11 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 15:06:11 INFO - Using env: {'DISPLAY': ':0', 15:06:11 INFO - 'HOME': '/home/cltbld', 15:06:11 INFO - 'LANG': 'en_US.UTF-8', 15:06:11 INFO - 'LANGUAGE': 'en_US:en', 15:06:11 INFO - 'LOGNAME': 'cltbld', 15:06:11 INFO - 'MAIL': '/var/mail/cltbld', 15:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:11 INFO - 'MOZ_NO_REMOTE': '1', 15:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:11 INFO - 'NO_EM_RESTART': '1', 15:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:11 INFO - 'PWD': '/builds/slave/test', 15:06:11 INFO - 'SHELL': '/bin/bash', 15:06:11 INFO - 'SHLVL': '1', 15:06:11 INFO - 'TERM': 'linux', 15:06:11 INFO - 'TMOUT': '86400', 15:06:11 INFO - 'USER': 'cltbld', 15:06:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', 15:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:11 INFO - '_': '/tools/buildbot/bin/python'} 15:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:11 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)) 15:06:11 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)) 15:06:11 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)) 15:06:11 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)) 15:06:11 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)) 15:06:11 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)) 15:06:11 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)) 15:06:11 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)) 15:06:11 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)) 15:06:11 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)) 15:06:11 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)) 15:06:11 INFO - Cleaning up... 15:06:11 INFO - Return code: 0 15:06:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:06:11 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')]} 15:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:11 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')]} 15:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:11 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 0x7f8b9691df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf9c0>, '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 0x15c08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0d50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', '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 15:06:11 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 15:06:11 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 15:06:11 INFO - Using env: {'DISPLAY': ':0', 15:06:11 INFO - 'HOME': '/home/cltbld', 15:06:11 INFO - 'LANG': 'en_US.UTF-8', 15:06:11 INFO - 'LANGUAGE': 'en_US:en', 15:06:11 INFO - 'LOGNAME': 'cltbld', 15:06:11 INFO - 'MAIL': '/var/mail/cltbld', 15:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:11 INFO - 'MOZ_NO_REMOTE': '1', 15:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:11 INFO - 'NO_EM_RESTART': '1', 15:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:11 INFO - 'PWD': '/builds/slave/test', 15:06:11 INFO - 'SHELL': '/bin/bash', 15:06:11 INFO - 'SHLVL': '1', 15:06:11 INFO - 'TERM': 'linux', 15:06:11 INFO - 'TMOUT': '86400', 15:06:11 INFO - 'USER': 'cltbld', 15:06:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', 15:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:11 INFO - '_': '/tools/buildbot/bin/python'} 15:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:11 INFO - Downloading/unpacking jsonschema 15:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:06:13 INFO - Downloading/unpacking functools32 (from jsonschema) 15:06:13 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 15:06:13 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 15:06:13 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 15:06:13 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 15:06:13 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 15:06:13 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 15:06:13 INFO - Downloading functools32-3.2.3-2.tar.gz 15:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:06:14 INFO - warning: no files found matching '*.txt' 15:06:14 INFO - no previously-included directories found matching 'build' 15:06:14 INFO - no previously-included directories found matching 'dist' 15:06:14 INFO - no previously-included directories found matching '.git*' 15:06:14 INFO - Installing collected packages: jsonschema, functools32 15:06:14 INFO - Running setup.py install for functools32 15:06:14 INFO - warning: no files found matching '*.txt' 15:06:14 INFO - no previously-included directories found matching 'build' 15:06:14 INFO - no previously-included directories found matching 'dist' 15:06:14 INFO - no previously-included directories found matching '.git*' 15:06:14 INFO - Successfully installed jsonschema functools32 15:06:14 INFO - Cleaning up... 15:06:14 INFO - Return code: 0 15:06:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:06: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')]} 15:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06: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')]} 15:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9691df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1530770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bf9c0>, '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 0x15c08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0d50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', '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 15:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:06:14 INFO - Using env: {'DISPLAY': ':0', 15:06:14 INFO - 'HOME': '/home/cltbld', 15:06:14 INFO - 'LANG': 'en_US.UTF-8', 15:06:14 INFO - 'LANGUAGE': 'en_US:en', 15:06:14 INFO - 'LOGNAME': 'cltbld', 15:06:14 INFO - 'MAIL': '/var/mail/cltbld', 15:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:14 INFO - 'MOZ_NO_REMOTE': '1', 15:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:14 INFO - 'NO_EM_RESTART': '1', 15:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:14 INFO - 'PWD': '/builds/slave/test', 15:06:14 INFO - 'SHELL': '/bin/bash', 15:06:14 INFO - 'SHLVL': '1', 15:06:14 INFO - 'TERM': 'linux', 15:06:14 INFO - 'TMOUT': '86400', 15:06:14 INFO - 'USER': 'cltbld', 15:06:14 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', 15:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:14 INFO - '_': '/tools/buildbot/bin/python'} 15:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:14 INFO - Downloading/unpacking flake8 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:06:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:06:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:06:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:06:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:06:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:06:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:06:17 INFO - no previously-included directories found matching 'docs/_build' 15:06:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:06:17 INFO - Running setup.py install for pep8 15:06:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:06:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:06:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:06:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:06:17 INFO - no previously-included directories found matching 'docs/_build' 15:06:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:06:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:06:17 INFO - Cleaning up... 15:06:17 INFO - Return code: 0 15:06:17 INFO - Running post-action listener: _resource_record_post_action 15:06:17 INFO - Running post-action listener: _start_resource_monitoring 15:06:17 INFO - Starting resource monitoring. 15:06:17 INFO - ##### 15:06:17 INFO - ##### Finished create-virtualenv step (success) 15:06:17 INFO - ##### 15:06:17 INFO - ##### 15:06:17 INFO - ##### Running install step. 15:06:17 INFO - ##### 15:06:17 INFO - Running pre-action listener: _resource_record_pre_action 15:06:17 INFO - Running main action method: install 15:06:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:17 INFO - Reading from file tmpfile_stdout 15:06:17 INFO - Detecting whether we're running mozinstall >=1.0... 15:06:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:06:17 INFO - Reading from file tmpfile_stdout 15:06:17 INFO - Output received: 15:06:17 INFO - Usage: mozinstall [options] installer 15:06:17 INFO - Options: 15:06:17 INFO - -h, --help show this help message and exit 15:06:17 INFO - -d DEST, --destination=DEST 15:06:17 INFO - Directory to install application into. [default: 15:06:17 INFO - "/builds/slave/test"] 15:06:17 INFO - --app=APP Application being installed. [default: firefox] 15:06:17 INFO - mkdir: /builds/slave/test/build/application 15:06:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:06:33 INFO - Reading from file tmpfile_stdout 15:06:33 INFO - Output received: 15:06:33 INFO - /builds/slave/test/build/application/firefox/firefox 15:06:33 INFO - Running post-action listener: _resource_record_post_action 15:06:33 INFO - ##### 15:06:33 INFO - ##### Finished install step (success) 15:06:33 INFO - ##### 15:06:33 INFO - ##### 15:06:33 INFO - ##### Running run-tests step. 15:06:33 INFO - ##### 15:06:33 INFO - Running pre-action listener: _resource_record_pre_action 15:06:33 INFO - Running main action method: run_tests 15:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:33 INFO - Python 2.7.3 15:06:33 INFO - Return code: 0 15:06:33 INFO - grabbing minidump binary from tooltool 15:06:33 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')]} 15:06:33 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 0x15bf9c0>, '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 0x15c08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:33 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 15:06:33 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 15:06:33 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 15:06:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:33 INFO - Return code: 0 15:06:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:06:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:06:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:06:34 INFO - Return code: 0 15:06:34 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:06:34 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:06:34 INFO - Using env: {'DISPLAY': ':0', 15:06:34 INFO - 'HOME': '/home/cltbld', 15:06:34 INFO - 'LANG': 'en_US.UTF-8', 15:06:34 INFO - 'LANGUAGE': 'en_US:en', 15:06:34 INFO - 'LOGNAME': 'cltbld', 15:06:34 INFO - 'MAIL': '/var/mail/cltbld', 15:06:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:34 INFO - 'MOZ_NO_REMOTE': '1', 15:06:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:34 INFO - 'NO_EM_RESTART': '1', 15:06:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:34 INFO - 'PWD': '/builds/slave/test', 15:06:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:34 INFO - 'SHELL': '/bin/bash', 15:06:34 INFO - 'SHLVL': '1', 15:06:34 INFO - 'TERM': 'linux', 15:06:34 INFO - 'TMOUT': '86400', 15:06:34 INFO - 'USER': 'cltbld', 15:06:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223', 15:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:34 INFO - '_': '/tools/buildbot/bin/python'} 15:06:34 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:06:34 INFO - mozversion application_buildid: 20160523144654 15:06:34 INFO - mozversion application_changeset: c90fe6f633f400db7eb108f02397bcc391c12a0d 15:06:34 INFO - mozversion application_display_name: Nightly 15:06:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:34 INFO - mozversion application_name: Firefox 15:06:34 INFO - mozversion application_remotingname: firefox 15:06:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:06:34 INFO - mozversion application_vendor: Mozilla 15:06:34 INFO - mozversion application_version: 49.0a1 15:06:34 INFO - mozversion platform_buildid: 20160523144654 15:06:34 INFO - mozversion platform_changeset: c90fe6f633f400db7eb108f02397bcc391c12a0d 15:06:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:06:34 INFO - mozversion platform_version: 49.0a1 15:06:34 INFO - using testdate: 1464041194 15:06:34 INFO - actual date: 1464041194 15:06:34 INFO - starting webserver on 'localhost:48093' 15:06:34 INFO - SUITE-START | Running 2 tests 15:06:34 INFO - TEST-START | dromaeo_css 15:06:34 INFO - operating with platform_type : linux_ 15:06:34 INFO - Initialising browser for dromaeo_css test... 15:06:34 INFO - TEST-INFO | started process 22494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt02k5R/profile http://localhost:48093/getInfo.html) 15:06:39 INFO - PROCESS | 22494 | __metrics Screen width/height:1600/1200 15:06:39 INFO - PROCESS | 22494 | colorDepth:24 15:06:39 INFO - PROCESS | 22494 | Browser inner width/height: 1024/697 15:06:39 INFO - PROCESS | 22494 | __metrics 15:06:40 ERROR - PROCESS | 22494 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:06:41 INFO - TEST-INFO | 22494: exit 0 15:06:41 INFO - Browser initialized. 15:06:41 INFO - Running cycle 1/1 for dromaeo_css test... 15:06:41 INFO - TEST-INFO | started process 22577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt02k5R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:53 INFO - PROCESS | 22577 | RSS: Main: 155361280 15:06:53 INFO - PROCESS | 22577 | 15:07:45 INFO - PROCESS | 22577 | 1464041265015 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] 15:09:56 INFO - PROCESS | 22577 | Cycle 1(1): loaded http://localhost:48093/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48093/tests/dromaeo/cssquery-ext.html) 15:09:57 INFO - PROCESS | 22577 | RSS: Main: 267190272 15:09:57 INFO - PROCESS | 22577 | 15:13:00 INFO - PROCESS | 22577 | Cycle 1(1): loaded http://localhost:48093/tests/dromaeo/cssquery-ext.html (next: http://localhost:48093/tests/dromaeo/cssquery-jquery.html) 15:13:00 INFO - PROCESS | 22577 | RSS: Main: 236515328 15:13:00 INFO - PROCESS | 22577 | 15:16:03 INFO - PROCESS | 22577 | Cycle 1(1): loaded http://localhost:48093/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48093/tests/dromaeo/cssquery-mootools.html) 15:16:03 INFO - PROCESS | 22577 | RSS: Main: 231768064 15:16:03 INFO - PROCESS | 22577 | 15:19:05 INFO - PROCESS | 22577 | Cycle 1(1): loaded http://localhost:48093/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48093/tests/dromaeo/cssquery-prototype.html) 15:19:06 INFO - PROCESS | 22577 | RSS: Main: 235847680 15:19:06 INFO - PROCESS | 22577 | 15:22:09 INFO - PROCESS | 22577 | Cycle 1(1): loaded http://localhost:48093/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48093/tests/dromaeo/cssquery-yui.html) 15:22:09 INFO - PROCESS | 22577 | RSS: Main: 216977408 15:22:09 INFO - PROCESS | 22577 | 15:25:12 INFO - PROCESS | 22577 | Cycle 1(1): loaded http://localhost:48093/tests/dromaeo/cssquery-yui.html (next: http://localhost:48093/tests/dromaeo/cssquery-dojo.html) 15:25:12 INFO - PROCESS | 22577 | RSS: Main: 263090176 15:25:12 INFO - PROCESS | 22577 | 15:25:12 INFO - PROCESS | 22577 | __start_tp_report 15:25:12 INFO - PROCESS | 22577 | _x_x_mozilla_page_load 15:25:12 INFO - PROCESS | 22577 | _x_x_mozilla_page_load_details 15:25:12 INFO - PROCESS | 22577 | |i|pagename|runs| 15:25:12 INFO - PROCESS | 22577 | |0;dojo.html;2654.0976068136833;2677.5849743289773;2720.102366219148;2728.045184185535;2729.1403207989474;4555.88610284743;4628;4703.835365762199;4784.354112194857;4837.298591704201;4672.602828759559;4692.648051396141;4728.125296820082;4738.028704115656;4756;4286.421333120028;4340.370646256291;4374.278244089722;4412.3602077698715;4529.750863702495;4462.1968045751755;4485.2599321111975;4487.259602165639;4516.887077823064;4537.7277363358135;4305.784710764449;4366.279563871957;4368.781560921973;4407.427034485529;4413.58070983256;4332.025294308787;4352.455943007124;4363.541828108035;4372.715773474714;4423.668224883147;4380.3210502372185;4386.517483076859;4393.692441529094;4403.493598236179;4440.733555986619;4579.335996280554;4643.117807616542;4710.3641008463765;4771.260454629503;4771.427428708543;5085.466026067246;5108.948910510921;5160.974195129038;5163.096458119814;5168.638195326329;5126.487351264881;5183.170692689152;5193.662411943249;5194.6883187008525;5199.974000129975;4633.907321853544;4683.039976804746;4723.456802467692;4773.260144677546;4827.565519103297;5177.689338639693;5186.066508028591;5193.974030129901;5240.633155679066;5256;5002.674826136289;5004.449510553836;5028.924566131511;5046.243063540425;5052.418971818214;4980.5019498049905;5038.6976781392505;5091.847244582668;5096.490350964874;5123.6157288202785;5055.443901170868;5056.696598204119;5069.847904562869;5074.517920797518;5131.999260144236;5046.243063540498;5047.990401919631;5052.469490703424;5056.191009438546;5057.747112644353;4162.91674166515;4195.454590903163;4238.36424536322;4282.721623094489;4286.142771445723;3743.5694895086867;3756.3238617048646;3790.962090379061;3798.012516745666;3804.7907365094634;4418.64650827933;4429.069895322018;4433.556644335606;4473.821047158077;4482.282834746425;4958.702477851269;5118.206677964921;5132.640715149978;5142.357205349332;5142.408623008402;4450.866474005785;4471.217536931024;4474.32885067236;4491.281394976788;4519.88700282489;4616.76916154191;4620.722756634613;4627.467841198305;4627.652926030494;4673.439187297546;4738.194506933761;4806.351142595845;4818.349522814376;4842.346283251716;4885.682430642068;5057.115004874058;5091.9490805092955;5099.5665368442615;5106.795728170831;5117.334746482933;4812.181929071996;4812.807487700453;4820.060088282751;4829.203181475017;4832.903341933212;4915.926261106015;4970.080535101018;5001.399832020181;5018.1469150245275;5054.69671819692;5084.898302033865;5104.336436263262;5106.285120083117;5120.743962801919;5168.457311982338;4795.352627395257;4962.404511458648;4965.975170124127;4976.825811096739;4981.6014718823135;4928.728919909439;4969.801207951641;4975.502449754996;4975.975120124376;4991.650584459053;4919.188333925005;4926.556609905126;4971.552560269593;4975.203967365204;4977.751112444435;4846.200376937766;4916.237983112624;5038.722870242172;5084.745762711776;5092.541671249605;4853.053654537332;4866.343043689199;4879.780409881493;4886.315915771866;4914.140025495452 15:25:12 INFO - PROCESS | 22577 | |1;ext.html;539.9516885331312;573.9856503587413;576.8500189950613;579.3192998227088;600.4145957691252;40736.38895416571;40760.388594171076;41822.16355672885;41829.58170418295;41833.58166418335;41260.58739412605;41920;41945;42007.369889451686;42028.36957445633;7376.409887209037;7696.73061442851;7904.644291006918;9927.354721943087;10011.299209055369;9764.316497845153;10065.396076235413;10070.04334588213;10088.949555252213;10089.394636321807;10093.747656308578;10165.440900750456;10174.491275436236;10177.898221017806;10184.439855807928;10017.649382271622;10102.343347682377;10103.696889093339;10105.848412273821;10109.39343639384;9934.701958941243;10001.199904007735;10031.849522257173;10038;10039.598416063349;37698.246035079144;38066.42900356497;38103.23793524114;38122.42816357757;38151.61848381509;3191.5372271020806;3387.7459190560808;3436.1409647588102;3620.601733809279;3856.093817952779;29431.11706648804;29613.555796663066;30325.24186895323;31953.36093278145;32013.519797203062;3536.257385948954;3545.62770909056;3567.30437564675;3567.4470457079196;3595.5505561804775;272556;273411.632941836;273860;275226;276227;54850.72574637101;55177.448225518034;55210.723946380815;55258;55290.894182116936;58863.70568147132;59093.113603295984;59172.40827591669;59179.70410147922;59204.40795591989;11855.585054523222;12153.817692734616;12174.269543827399;12209.755804883853;12221.877781222074;9498.287628427895;9540;9550.952245238868;9553.140217380469;9558.187554057844;17926.28255949719;18728.625427491374;18769.24923003092;18934.147963341682;19123.71314430285;6816.216135144423;6845.452363810883;6996;7106.751263705745;7153.391961683211;915.272358475014;963.6145541783203;966.5119114846957;995.9253056020827;1005.5374527717186;27987.160385188476;28475.572866406605;28478.857605712252;29013;29140.27149321284;951.9809603808023;961.3462845265286;975.4683697384942;975.9658411955547;1035.1253191053547;14839.40642374293;15065.698686026219;15100.39598416073;15296.158711270764;15520.767188492182;404160;405237;410998;411662;412523;49254.75372623186;49521;49917;49951.25073123906;49952;1197.7944743068108;1216.5255550335376;1236.3756303067073;1238.4365113872987;1239.2440611227144;26195.214143575722;27400.58899116475;27883.16350509488;27992.860035700505;28089;42898.35652465278;42950.570494294654;43083;43147.352789708806;43272;329902;330649;330845;331526;332161;21970.34088977333;21976.34070977873;22556.210532631278;24692;25066.3733406659;37202.627973721;37242.62757372392;37311.2537749238;42842.1431571373;43621;36194.276114477034;36218.63781362153;36831.63168368282;36918.26163476662;37207.25585488329;35988;36445;36753.816230918674;36996;37299.62700372961;36398.8180059098;37264.627353726115;37610.435843461826;38607.61392386153;39121.6087839118;31603.36793264076;33896.491552626234;33964.49053264252;34008.31983360369;34078.82960585181;25168;27180.592291116045;27349.453010939273;27422.177334679993;27456.725432745417 15:25:12 INFO - PROCESS | 22577 | |2;jquery.html;363.4530032301386;366.55463611711764;366.7909291703728;377.99244015119683;381.9732618716689;15827.841721582796;16997.745033824503;17051;17489.7376539352;17511.562210944732;16311.347546098143;16789.41237056703;17389.739153912702;17449.302027918868;17507.82492175078;5072.670276432039;5211.035958347698;5217.452167522412;5255.211718242256;5261.579073674096;3786.734928555002;3994.6005399460114;5181.9740901295445;5721.427857214266;6052.334243233241;6058.303295121052;6095.055266433687;6114.847128821771;6122.877542449149;6124.724387402578;5983.58114931955;6028.4574388305045;6107.206063211754;6112.205413296265;6136.723847426876;3434.4848272759036;4993.475685053054;5305.230741542493;5318.574514038867;5359.38367087786;19676.311329103555;20293;20373.694394584094;20457.2839950601;20465.18139274442;2183.170395249811;2278.532900755358;2334.8482348647285;2524.6213068039756;2549.4901019796116;12531.749365012649;12871.678208044781;13124.606261812161;13325.268924701099;13515.864841351558;1724.3619860651513;1814.165483877418;1818.4181062060145;1819.8362147406665;1825.6074943886995;65882.3411765881;68388.6580567099;68541;68798.65600672015;68856.6557167221;9551.331406801597;9572.76068098303;9863.260255480867;9884.752881178028;10081.747956301151;13545.1195672281;13576.592702218752;13622.93188534051;13663.18020918748;13685.589432317047;6529.11856899322;6565.80302590923;6603.141591593062;6686.231083425469;6705.463562914955;5721.885562288731;5802.506786923159;6029.547783916224;6058.636481811105;6169.56813023084;5958.344582095966;6077.24034495688;6090.482309003784;6272.905906411407;6363.9045414318825;1519.308714534884;1637.90172589645;1711.4523352527071;1743.1894169211123;1778.6264884374427;820.2781552233996;872.5549969515466;894.6555576103248;922.1378011559214;992.8212921674024;16820.6635867282;17751.378701745634;17753;18432.275800579486;18561.53596160107;898;910.8497097978759;912.183595681861;923.072312326108;971.0338213477635;10158;10434.37393756377;10437.217208709377;10458.26792124544;10540.789184216273;361392;361990;362653;363598;385580;73890.26109738834;74937;75530;76106.85839712409;77727.22272777313;947.332130847737;948.1561410344799;949.6296444386695;952.1620973543238;953.1564565359567;16148.434804781777;16237.67524649524;16291;16447.506574802774;16451.91774041122;24939;26695.33261668474;29888.402231955675;34425.139371515914;34565.65434345624;30588.694113059475;46402.30396543987;46930.29604555866;47975.5202447985;48080.5191948076;6346.270178929298;6408.423241908251;6805.183377994672;6841.076454678555;7877.724279650185;7394.963025185055;10096.19230461576;10353.689389318333;10373.792524149323;10575.471226438802;6432.067350234096;8879.534876745265;8953.641854326015;9042.276617870686;9272.119148680864;9208.447493150432;9268.53657317145;9329.72010839676;9348.252139828934;9487.57305921249;9147.725568232963;9463.195628371666;9629.470379129216;9641.842978842584;9722.27082968766;6788.151481064867;6811.080504131879;6819.215790183994;6894.724211031503;7055.435565154673;8559.63045912651;9832.803343933225;9913.355631883904;9975.50122493887;10122.898771012196 15:25:12 INFO - PROCESS | 22577 | |3;mootools.html;1126.6169502369194;1417.305520295055;1428.2073449235672;1532.923353832308;1727.50766031681;6542.803715888519;7546.7358642447525;7778.9222107778905;7786.299233069023;7982.720604778834;7651;7769.689212431496;7792.3376512996465;7803.219678032194;7812.492188007775;2104.358170757922;2125.4792575818947;2129.6273152198382;2134.2743467221144;2134.7011418401435;2067.865588736735;2119.6502577074843;2178.106976139783;2178.477165480281;2181.55278167976;2173.434906924203;2190.145843121184;2198.824094072478;2200.9559808803815;2214.6345852934246;2110.303599812066;2119.788021197883;2121.2151503943487;2121.575684863026;2122.108714339981;2103.8737675739503;2157.557700671359;2161.070739581979;2163.2212403534713;2165.07984106754;7574.5076570022775;7703;7720.729774457867;7792.064952205715;7815.882761758578;4318.52496225415;4490.865274041784;4493.505714371417;4496.190685676577;4497.550244975509;2971.4948458762065;2976.226181192884;3037.3773376457775;3040.6807285234954;3050.8932187373557;922.8800255966748;949.2026697574001;952.8570714392896;958.1328897347911;972.246508955558;10749.140068794555;10810.621628242974;10843.349399036004;10848.18638602108;10855.294405863593;3929.2337994090876;4100.2619528484565;4159.771212583337;4170.854020109342;4179.832806687759;8505.192006759347;8572.742817715478;8585.914140858511;8587.785305367292;8603.913960860436;4375.934360984587;4408.603225709701;4418.226810308183;4418.270985287456;4421.248387774086;3448.3103379324234;3785.981070094687;3951.130751234724;4018.3972404139613;4080.6327430531396;3404.7957122572725;3411.846466908995;3510.526078979356;3512.5960514540643;3526.3828829954655;976.5947131940165;976.7411635916487;985.2167526816198;1013.7668336282696;1015.1726343030407;836.9204925532065;842.6629348260744;843.5529169540154;845.1843970568431;869.8564736818354;4855.271709243571;5179.792808287626;5268.868278293074;5341.786328546892;5367.490088441592;867.5445391169686;883.7081870034071;891.0910870911633;908.981820363589;909.1408618855119;3501.9474707879403;3594.478800573902;3625.4018087015875;3836.271108489378;3976.880693579197;9696.224302055818;9787.804243915081;9890.456024918698;9899.703008909744;9902.158316543031;9715.319927605;9873.259505537113;9885.209183265322;9900.653477128266;9914.305998580174;7163.498555101197;7226.566406015656;7251.419886409075;7403.037605111301;7407;5271.7891284349735;5330.067238233371;5357.089294819968;5398.40617532079;5403.83788486346;8795.780105497413;8838.646454141763;9063.456192628464;9091.090890910857;9104.590293436944;9043.412178208395;9116.179543841086;9149;9175.632974681204;9251.583678734338;5893.410658934073;6473.579217350857;6660.467162627075;6690.264070952288;6807.761728339682;7692.076950765944;7728.188540203198;7764.6894124234395;7766.223377662189;7780.92219077802;6680.532362734756;6767.89848152288;6771.830704232433;6980.7905762827195;7013.719451221894;6514.283428822731;6516.967415162894;6539.182602174728;6592.472602191909;6602.8349291268105;6328.335524769833;6330.240371155491;6356.555041147075;6378.266499352634;6445.097686324012;4543.772811359353;4754.857354279377;4775.5463230993;4828.444728856086;4866.075445665312;4681.836135735233;4717;4774.092922344744;4811.807527698993;4862.562369386772 15:25:12 INFO - PROCESS | 22577 | |4;prototype.html;276.72051228259454;282.5054081017809;288.44474386805393;291.125168867553;292.2809887676317;4662.370579971703;4805.159097157996;4808.687435316702;4834.178189707749;4871.220604703248;4627.976860115703;4765.856194513318;4778.928316075253;4811.374521312233;4812.542808433193;3814.542254929412;3815.9618403815884;3821.6751576115926;3821.9617803821884;3832;3608.8376023078895;3674.7060235181257;3799.278137153946;3824.5028146340937;3829.942550861739;3747.4378843173467;3756.530433695788;3790.185110201306;3795.7153213509096;3799.886003419902;3755.3052685253315;3772.2832661794446;3777.26245926874;3778.471014058034;3787.14789172434;3363.461846104636;3382.6448222936483;3387.7967321960514;3389.7288216942834;3424.7945123292684;4492.393526873863;4578.244589642738;4598.977005114953;4612.3542704021465;4613.261878099488;4290.485141782975;4297.806598703066;4303.763293018883;4309.1381723655395;4310.655147588185;4741.786619602126;4883.362983988642;4935.851924442272;4941.382327209099;4956.2565615157655;3519.331327047853;3525.7355698322726;3530.2057037166687;3532.876349327761;3543.3799085159994;5185.481451854822;5203.4796520348045;5206.7917283308625;5215.869603259911;5218.842600226884;3605.8737944172353;3608.296382205445;3610.5125808016105;3620.5474315710535;3624.257027309395;3452.8273586320583;3671.430928206079;3697.6117507661306;3698.816378758825;3701.444783282529;4210.831566737357;4214.894627634334;4221.662267018631;4222.809973551136;4242.766647834337;4769.785359658824;4971.130052240916;5022.974885125551;5036.924446133311;5038.496150385005;1243.3348158735214;1273.2933222061845;1283.9422225999851;1287.2598256002836;1290.5160564788205;787.4173111897269;801.3669201330883;813.9267465928095;820.335528222142;822.942394032424;3993.4608827807874;3997.1413292818397;3998.620131087542;4029.879103626896;4034.2536630722825;4559.540946896961;4561.680682352204;4570.514582760616;4587.816487340469;4590.908181836345;3951;3989.6608788253325;3989.8204580793936;3989.960100399017;4036.919261614751;2330.4290448840143;2417.16607770319;2417.504411595619;2450.877456127222;2451.987740061324;4312.805923733439;4353.36876152956;4354.760488173118;4364.4980827204645;4399.5820397062225;4620.2607582786595;4652.418447694038;4662.4405071390975;4664.6239359389065;4671.95328046722;4166.729162604482;4352.8041238145;4368.650507959355;4379.664202418229;4383.627391671744;4490.685652004328;4534.501204867396;4555.24623020133;4560.315952607136;4573.977130114461;4398.69209155356;4447.532314336197;4449.354843547732;4481.126180394792;4489.530758082976;4151.398047283187;4332.988572941776;4356.411884395566;4370.344448332648;4375.337371798696;3313.5526703894666;3316.585426821647;3331.500824628878;3337.2824842658947;3342.4819153031317;4495.865124046284;4568.291914753218;4607.124646317189;4635.629149667951;4966.801327946841;4807.903841923072;4996.150654388835;5022.673526220784;5071.7827721345875;5075.086484432837;4971.577415919687;4992.400911890596;5003.249512573143;5020.820107274714;5029.295898574275;4742.115620910467;4922.852314430573;4941.160002799461;4943.307936888767;4945.653804233669;5018.874528136826;5037.924431133462;5050.646454748133;5056.191009438472;5068.670536415121;4940.827071052496;4943.530364615356;4963.70217786934;4993.650444468997;5003.299538064746 15:25:12 INFO - PROCESS | 22577 | |5;yui.html;692.7506097804791;716.0476566166999;726.5241266970133;770.3182683325256;777.2654841175084;11718.882811171885;12508.874911250896;12515.24908505488;12539.373031348441;12544.059195560323;12242.57150999713;12260.509579616804;12262.264264144158;12292.201006934543;12305.261684298948;622.2377587455354;775.6393277126135;804.4047404920346;805.8509175802466;808.6118663041714;802.1136644008375;807.4267270238138;811.2860682599304;811.8660421030523;811.8741595052776;660.3561527510686;843.5402705525503;844.9155084491563;846;846.5894041389952;828.8715249136394;853.7993571510659;855.0936007831718;857.9099194584542;858.2576071697937;606.0333767640606;609.9969500152515;614.5206738743786;614.9169862068653;615.1019511513151;12520.499180032788;12548.247105173628;12570.497180112785;12582.68543286416;12594.496220151183;12454.377281135998;12863.807042894365;12889.162204456774;13013.934930325382;13208.825815710197;9726.124648781644;9884.703458896245;9896.653617123366;10079.44563049032;10202.540885660163;3319.850606722703;3344.2642618623863;3387.5257463955068;3398.3882901077795;3471.9410579773157;47281.290780638315;48073.519264807255;48150.759246203896;48244.51755482436;48442.27336589989;10198.949005254926;10220;10241.692749217535;10362.637307694346;10372.688819335432;18390.356337528123;18441.53896152607;18477;18501.44495665132;18524.536886577942;6788.287229840895;6812.523123381316;6835.282295359015;6975;7032.437405007587;3614.2229420674157;3676.8713095041544;3697.759645623026;3714.981425092857;3764.0401697567495;2712.0778935161743;2732.3715545424666;2803.1170181393204;2806.116073436861;2834.5039618067167;407.60055145956534;512.8743457852776;517.9326687530597;540.7485519233576;546.3498436860124;472.9929051064237;549.2420459765498;595.5503594785908;632.7500637248261;641.7433026789322;8367.748967530984;8413.242808147295;8648.654053837776;8809.207171354608;8872.512011839412;601.7412512619528;602.7890238416519;616.3066550131102;617.4844005255572;621.1645337021698;3801.904952376213;3926.0773718176206;3945.585713500099;4007.8196481158416;4020.537638171589;55273.44726552763;56385.7180714102;56423.43576564264;57033.714831425576;57093.714531427075;49300.26049609187;50463.24305135426;50647.74676126596;50667.23999140016;52970;47157.29264060973;47549.5245047552;47741.761291193325;47940.28089578659;48674.75662621735;7637.656305466378;7641.465097443125;7790.961045194737;7833.5691536966015;7874.1338452769005;32201.838990805834;32412.189695257806;32632.510512342807;32737.508937366434;32826.83586582052;38050.80974595109;40528;41743.16513669649;41874.37188442115;42474;9836.557354919189;9885.851712224467;9920.355176913477;9943.30396872212;10050.798984020425;9787.804243915225;11026.669199924016;11141.498632561392;11225.101991840796;11573.826392604286;11059.557617695524;11170.944145279222;11198.832017519906;11567.132465065322;11619.47712352963;11357.375344355809;11498.532894442966;11657.06743460538;11678.474468649101;11742.236754610924;11077;11122.388268645302;11134.832977505506;11140.442977851237;11200.607978720705;9318.43207988086;9346.672866449642;9359.532023398666;9693.030696930533;9708.126268635575;9761.17030052425;9928.305018648625;9933.304668673123;9947.701568952943;10034.799304014025 15:25:12 INFO - PROCESS | 22577 | __end_tp_report 15:25:12 INFO - PROCESS | 22577 | __start_cc_report 15:25:12 INFO - PROCESS | 22577 | _x_x_mozilla_cycle_collect,1109 15:25:12 INFO - PROCESS | 22577 | __end_cc_report 15:25:12 INFO - PROCESS | 22577 | __startTimestamp1464042312805__endTimestamp 15:25:12 INFO - PROCESS | 22577 | 15:25:12 INFO - PROCESS | 22577 | ------- Summary: start ------- 15:25:12 INFO - PROCESS | 22577 | Number of tests: 6 15:25:12 INFO - PROCESS | 22577 | 15:25:12 INFO - PROCESS | 22577 | [#0] dojo.html Cycles:165 Average:4714.38 Median:4832.90 stddev:487.33 (10.1%) stddev-sans-first:461.25 15:25:12 INFO - PROCESS | 22577 | Values: 2654.1 2677.6 2720.1 2728.0 2729.1 4555.9 4628.0 4703.8 4784.4 4837.3 4672.6 4692.6 4728.1 4738.0 4756.0 4286.4 4340.4 4374.3 4412.4 4529.8 4462.2 4485.3 4487.3 4516.9 4537.7 4305.8 4366.3 4368.8 4407.4 4413.6 4332.0 4352.5 4363.5 4372.7 4423.7 4380.3 4386.5 4393.7 4403.5 4440.7 4579.3 4643.1 4710.4 4771.3 4771.4 5085.5 5108.9 5161.0 5163.1 5168.6 5126.5 5183.2 5193.7 5194.7 5200.0 4633.9 4683.0 4723.5 4773.3 4827.6 5177.7 5186.1 5194.0 5240.6 5256.0 5002.7 5004.4 5028.9 5046.2 5052.4 4980.5 5038.7 5091.8 5096.5 5123.6 5055.4 5056.7 5069.8 5074.5 5132.0 5046.2 5048.0 5052.5 5056.2 5057.7 4162.9 4195.5 4238.4 4282.7 4286.1 3743.6 3756.3 3791.0 3798.0 3804.8 4418.6 4429.1 4433.6 4473.8 4482.3 4958.7 5118.2 5132.6 5142.4 5142.4 4450.9 4471.2 4474.3 4491.3 4519.9 4616.8 4620.7 4627.5 4627.7 4673.4 4738.2 4806.4 4818.3 4842.3 4885.7 5057.1 5091.9 5099.6 5106.8 5117.3 4812.2 4812.8 4820.1 4829.2 4832.9 4915.9 4970.1 5001.4 5018.1 5054.7 5084.9 5104.3 5106.3 5120.7 5168.5 4795.4 4962.4 4966.0 4976.8 4981.6 4928.7 4969.8 4975.5 4976.0 4991.7 4919.2 4926.6 4971.6 4975.2 4977.8 4846.2 4916.2 5038.7 5084.7 5092.5 4853.1 4866.3 4879.8 4886.3 4914.1 15:25:12 INFO - PROCESS | 22577 | 15:25:12 INFO - PROCESS | 22577 | [#1] ext.html Cycles:180 Average:49609.99 Median:19907.44 stddev:90185.15 (453.0%) stddev-sans-first:90362.89 15:25:12 INFO - PROCESS | 22577 | Values: 540.0 574.0 576.9 579.3 600.4 40736.4 40760.4 41822.2 41829.6 41833.6 41260.6 41920.0 41945.0 42007.4 42028.4 7376.4 7696.7 7904.6 9927.4 10011.3 9764.3 10065.4 10070.0 10088.9 10089.4 10093.7 10165.4 10174.5 10177.9 10184.4 10017.6 10102.3 10103.7 10105.8 10109.4 9934.7 10001.2 10031.8 10038.0 10039.6 37698.2 38066.4 38103.2 38122.4 38151.6 3191.5 3387.7 3436.1 3620.6 3856.1 29431.1 29613.6 30325.2 31953.4 32013.5 3536.3 3545.6 3567.3 3567.4 3595.6 272556.0 273411.6 273860.0 275226.0 276227.0 54850.7 55177.4 55210.7 55258.0 55290.9 58863.7 59093.1 59172.4 59179.7 59204.4 11855.6 12153.8 12174.3 12209.8 12221.9 9498.3 9540.0 9551.0 9553.1 9558.2 17926.3 18728.6 18769.2 18934.1 19123.7 6816.2 6845.5 6996.0 7106.8 7153.4 915.3 963.6 966.5 995.9 1005.5 27987.2 28475.6 28478.9 29013.0 29140.3 952.0 961.3 975.5 976.0 1035.1 14839.4 15065.7 15100.4 15296.2 15520.8 404160.0 405237.0 410998.0 411662.0 412523.0 49254.8 49521.0 49917.0 49951.3 49952.0 1197.8 1216.5 1236.4 1238.4 1239.2 26195.2 27400.6 27883.2 27992.9 28089.0 42898.4 42950.6 43083.0 43147.4 43272.0 329902.0 330649.0 330845.0 331526.0 332161.0 21970.3 21976.3 22556.2 24692.0 25066.4 37202.6 37242.6 37311.3 42842.1 43621.0 36194.3 36218.6 36831.6 36918.3 37207.3 35988.0 36445.0 36753.8 36996.0 37299.6 36398.8 37264.6 37610.4 38607.6 39121.6 31603.4 33896.5 33964.5 34008.3 34078.8 25168.0 27180.6 27349.5 27422.2 27456.7 15:25:12 INFO - PROCESS | 22577 | 15:25:12 INFO - PROCESS | 22577 | [#2] jquery.html Cycles:180 Average:23214.66 Median:5283.40 stddev:60635.70 (1147.7%) stddev-sans-first:60781.53 15:25:12 INFO - PROCESS | 22577 | Values: 363.5 366.6 366.8 378.0 382.0 15827.8 16997.7 17051.0 17489.7 17511.6 16311.3 16789.4 17389.7 17449.3 17507.8 5072.7 5211.0 5217.5 5255.2 5261.6 3786.7 3994.6 5182.0 5721.4 6052.3 6058.3 6095.1 6114.8 6122.9 6124.7 5983.6 6028.5 6107.2 6112.2 6136.7 3434.5 4993.5 5305.2 5318.6 5359.4 19676.3 20293.0 20373.7 20457.3 20465.2 2183.2 2278.5 2334.8 2524.6 2549.5 12531.7 12871.7 13124.6 13325.3 13515.9 1724.4 1814.2 1818.4 1819.8 1825.6 65882.3 68388.7 68541.0 68798.7 68856.7 9551.3 9572.8 9863.3 9884.8 10081.7 13545.1 13576.6 13622.9 13663.2 13685.6 6529.1 6565.8 6603.1 6686.2 6705.5 5721.9 5802.5 6029.5 6058.6 6169.6 5958.3 6077.2 6090.5 6272.9 6363.9 1519.3 1637.9 1711.5 1743.2 1778.6 820.3 872.6 894.7 922.1 992.8 16820.7 17751.4 17753.0 18432.3 18561.5 898.0 910.8 912.2 923.1 971.0 10158.0 10434.4 10437.2 10458.3 10540.8 361392.0 361990.0 362653.0 363598.0 385580.0 73890.3 74937.0 75530.0 76106.9 77727.2 947.3 948.2 949.6 952.2 953.2 16148.4 16237.7 16291.0 16447.5 16451.9 24939.0 26695.3 29888.4 34425.1 34565.7 30588.7 46402.3 46930.3 47975.5 48080.5 6346.3 6408.4 6805.2 6841.1 7877.7 7395.0 10096.2 10353.7 10373.8 10575.5 6432.1 8879.5 8953.6 9042.3 9272.1 9208.4 9268.5 9329.7 9348.3 9487.6 9147.7 9463.2 9629.5 9641.8 9722.3 6788.2 6811.1 6819.2 6894.7 7055.4 8559.6 9832.8 9913.4 9975.5 10122.9 15:25:12 INFO - PROCESS | 22577 | 15:25:12 INFO - PROCESS | 22577 | [#3] mootools.html Cycles:180 Average:5125.11 Median:5401.12 stddev:2903.25 (53.8%) stddev-sans-first:2895.84 15:25:12 INFO - PROCESS | 22577 | Values: 1126.6 1417.3 1428.2 1532.9 1727.5 6542.8 7546.7 7778.9 7786.3 7982.7 7651.0 7769.7 7792.3 7803.2 7812.5 2104.4 2125.5 2129.6 2134.3 2134.7 2067.9 2119.7 2178.1 2178.5 2181.6 2173.4 2190.1 2198.8 2201.0 2214.6 2110.3 2119.8 2121.2 2121.6 2122.1 2103.9 2157.6 2161.1 2163.2 2165.1 7574.5 7703.0 7720.7 7792.1 7815.9 4318.5 4490.9 4493.5 4496.2 4497.6 2971.5 2976.2 3037.4 3040.7 3050.9 922.9 949.2 952.9 958.1 972.2 10749.1 10810.6 10843.3 10848.2 10855.3 3929.2 4100.3 4159.8 4170.9 4179.8 8505.2 8572.7 8585.9 8587.8 8603.9 4375.9 4408.6 4418.2 4418.3 4421.2 3448.3 3786.0 3951.1 4018.4 4080.6 3404.8 3411.8 3510.5 3512.6 3526.4 976.6 976.7 985.2 1013.8 1015.2 836.9 842.7 843.6 845.2 869.9 4855.3 5179.8 5268.9 5341.8 5367.5 867.5 883.7 891.1 909.0 909.1 3501.9 3594.5 3625.4 3836.3 3976.9 9696.2 9787.8 9890.5 9899.7 9902.2 9715.3 9873.3 9885.2 9900.7 9914.3 7163.5 7226.6 7251.4 7403.0 7407.0 5271.8 5330.1 5357.1 5398.4 5403.8 8795.8 8838.6 9063.5 9091.1 9104.6 9043.4 9116.2 9149.0 9175.6 9251.6 5893.4 6473.6 6660.5 6690.3 6807.8 7692.1 7728.2 7764.7 7766.2 7780.9 6680.5 6767.9 6771.8 6980.8 7013.7 6514.3 6517.0 6539.2 6592.5 6602.8 6328.3 6330.2 6356.6 6378.3 6445.1 4543.8 4754.9 4775.5 4828.4 4866.1 4681.8 4717.0 4774.1 4811.8 4862.6 15:25:12 INFO - PROCESS | 22577 | 15:25:12 INFO - PROCESS | 22577 | [#4] prototype.html Cycles:180 Average:3998.23 Median:4372.84 stddev:1149.15 (26.3%) stddev-sans-first:1117.91 15:25:12 INFO - PROCESS | 22577 | Values: 276.7 282.5 288.4 291.1 292.3 4662.4 4805.2 4808.7 4834.2 4871.2 4628.0 4765.9 4778.9 4811.4 4812.5 3814.5 3816.0 3821.7 3822.0 3832.0 3608.8 3674.7 3799.3 3824.5 3829.9 3747.4 3756.5 3790.2 3795.7 3799.9 3755.3 3772.3 3777.3 3778.5 3787.1 3363.5 3382.6 3387.8 3389.7 3424.8 4492.4 4578.2 4599.0 4612.4 4613.3 4290.5 4297.8 4303.8 4309.1 4310.7 4741.8 4883.4 4935.9 4941.4 4956.3 3519.3 3525.7 3530.2 3532.9 3543.4 5185.5 5203.5 5206.8 5215.9 5218.8 3605.9 3608.3 3610.5 3620.5 3624.3 3452.8 3671.4 3697.6 3698.8 3701.4 4210.8 4214.9 4221.7 4222.8 4242.8 4769.8 4971.1 5023.0 5036.9 5038.5 1243.3 1273.3 1283.9 1287.3 1290.5 787.4 801.4 813.9 820.3 822.9 3993.5 3997.1 3998.6 4029.9 4034.3 4559.5 4561.7 4570.5 4587.8 4590.9 3951.0 3989.7 3989.8 3990.0 4036.9 2330.4 2417.2 2417.5 2450.9 2452.0 4312.8 4353.4 4354.8 4364.5 4399.6 4620.3 4652.4 4662.4 4664.6 4672.0 4166.7 4352.8 4368.7 4379.7 4383.6 4490.7 4534.5 4555.2 4560.3 4574.0 4398.7 4447.5 4449.4 4481.1 4489.5 4151.4 4333.0 4356.4 4370.3 4375.3 3313.6 3316.6 3331.5 3337.3 3342.5 4495.9 4568.3 4607.1 4635.6 4966.8 4807.9 4996.2 5022.7 5071.8 5075.1 4971.6 4992.4 5003.2 5020.8 5029.3 4742.1 4922.9 4941.2 4943.3 4945.7 5018.9 5037.9 5050.6 5056.2 5068.7 4940.8 4943.5 4963.7 4993.7 5003.3 15:25:12 INFO - PROCESS | 22577 | 15:25:12 INFO - PROCESS | 22577 | [#5] yui.html Cycles:180 Average:13418.28 Median:48112.14 stddev:15698.01 (32.6%) stddev-sans-first:15712.96 15:25:12 INFO - PROCESS | 22577 | Values: 692.8 716.0 726.5 770.3 777.3 11718.9 12508.9 12515.2 12539.4 12544.1 12242.6 12260.5 12262.3 12292.2 12305.3 622.2 775.6 804.4 805.9 808.6 802.1 807.4 811.3 811.9 811.9 660.4 843.5 844.9 846.0 846.6 828.9 853.8 855.1 857.9 858.3 606.0 610.0 614.5 614.9 615.1 12520.5 12548.2 12570.5 12582.7 12594.5 12454.4 12863.8 12889.2 13013.9 13208.8 9726.1 9884.7 9896.7 10079.4 10202.5 3319.9 3344.3 3387.5 3398.4 3471.9 47281.3 48073.5 48150.8 48244.5 48442.3 10198.9 10220.0 10241.7 10362.6 10372.7 18390.4 18441.5 18477.0 18501.4 18524.5 6788.3 6812.5 6835.3 6975.0 7032.4 3614.2 3676.9 3697.8 3715.0 3764.0 2712.1 2732.4 2803.1 2806.1 2834.5 407.6 512.9 517.9 540.7 546.3 473.0 549.2 595.6 632.8 641.7 8367.7 8413.2 8648.7 8809.2 8872.5 601.7 602.8 616.3 617.5 621.2 3801.9 3926.1 3945.6 4007.8 4020.5 55273.4 56385.7 56423.4 57033.7 57093.7 49300.3 50463.2 50647.7 50667.2 52970.0 47157.3 47549.5 47741.8 47940.3 48674.8 7637.7 7641.5 7791.0 7833.6 7874.1 32201.8 32412.2 32632.5 32737.5 32826.8 38050.8 40528.0 41743.2 41874.4 42474.0 9836.6 9885.9 9920.4 9943.3 10050.8 9787.8 11026.7 11141.5 11225.1 11573.8 11059.6 11170.9 11198.8 11567.1 11619.5 11357.4 11498.5 11657.1 11678.5 11742.2 11077.0 11122.4 11134.8 11140.4 11200.6 9318.4 9346.7 9359.5 9693.0 9708.1 9761.2 9928.3 9933.3 9947.7 10034.8 15:25:12 INFO - PROCESS | 22577 | -------- Summary: end -------- 15:25:12 INFO - PROCESS | 22577 | 15:25:13 INFO - TEST-INFO | 22577: exit 0 15:25:13 INFO - TEST-OK | dromaeo_css | took 1118850ms 15:25:13 INFO - TEST-START | kraken 15:25:13 INFO - operating with platform_type : linux_ 15:25:13 INFO - Initialising browser for kraken test... 15:25:13 INFO - TEST-INFO | started process 22757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxagAVi/profile http://localhost:48093/getInfo.html) 15:25:17 INFO - PROCESS | 22757 | __metrics Screen width/height:1600/1200 15:25:17 INFO - PROCESS | 22757 | colorDepth:24 15:25:17 INFO - PROCESS | 22757 | Browser inner width/height: 1024/697 15:25:17 INFO - PROCESS | 22757 | __metrics 15:25:18 ERROR - PROCESS | 22757 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:25:19 INFO - TEST-INFO | 22757: exit 0 15:25:19 INFO - Browser initialized. 15:25:19 INFO - Running cycle 1/1 for kraken test... 15:25:19 INFO - TEST-INFO | started process 22840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxagAVi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:31 INFO - PROCESS | 22840 | RSS: Main: 155078656 15:25:31 INFO - PROCESS | 22840 | 15:25:34 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48093/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:35 INFO - PROCESS | 22840 | RSS: Main: 210587648 15:25:35 INFO - PROCESS | 22840 | 15:25:38 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48093/tests/kraken/driver.html?testName=audio-dft) 15:25:38 INFO - PROCESS | 22840 | RSS: Main: 198983680 15:25:38 INFO - PROCESS | 22840 | 15:25:42 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48093/tests/kraken/driver.html?testName=audio-fft) 15:25:42 INFO - PROCESS | 22840 | RSS: Main: 266956800 15:25:42 INFO - PROCESS | 22840 | 15:25:45 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48093/tests/kraken/driver.html?testName=audio-oscillator) 15:25:45 INFO - PROCESS | 22840 | RSS: Main: 177885184 15:25:45 INFO - PROCESS | 22840 | 15:25:48 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48093/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:25:48 INFO - PROCESS | 22840 | RSS: Main: 180670464 15:25:48 INFO - PROCESS | 22840 | 15:25:52 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48093/tests/kraken/driver.html?testName=imaging-darkroom) 15:25:52 INFO - PROCESS | 22840 | RSS: Main: 216276992 15:25:52 INFO - PROCESS | 22840 | 15:25:56 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48093/tests/kraken/driver.html?testName=imaging-desaturate) 15:25:57 INFO - PROCESS | 22840 | RSS: Main: 215359488 15:25:57 INFO - PROCESS | 22840 | 15:26:00 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48093/tests/kraken/driver.html?testName=json-parse-financial) 15:26:00 INFO - PROCESS | 22840 | RSS: Main: 215949312 15:26:00 INFO - PROCESS | 22840 | 15:26:02 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48093/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:26:03 INFO - PROCESS | 22840 | RSS: Main: 209412096 15:26:03 INFO - PROCESS | 22840 | 15:26:05 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48093/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:26:05 INFO - PROCESS | 22840 | RSS: Main: 214921216 15:26:05 INFO - PROCESS | 22840 | 15:26:08 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48093/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:26:08 INFO - PROCESS | 22840 | RSS: Main: 217726976 15:26:08 INFO - PROCESS | 22840 | 15:26:11 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:26:12 INFO - PROCESS | 22840 | RSS: Main: 220626944 15:26:12 INFO - PROCESS | 22840 | 15:26:15 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:26:15 INFO - PROCESS | 22840 | RSS: Main: 220532736 15:26:15 INFO - PROCESS | 22840 | 15:26:17 INFO - PROCESS | 22840 | Cycle 1(1): loaded http://localhost:48093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48093/tests/kraken/driver.html?testName=ai-astar) 15:26:18 INFO - PROCESS | 22840 | RSS: Main: 266477568 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | __start_tp_report 15:26:18 INFO - PROCESS | 22840 | _x_x_mozilla_page_load 15:26:18 INFO - PROCESS | 22840 | _x_x_mozilla_page_load_details 15:26:18 INFO - PROCESS | 22840 | |i|pagename|runs| 15:26:18 INFO - PROCESS | 22840 | |0;ai-astar;114;110;115;115;116;114;113;113;113;114 15:26:18 INFO - PROCESS | 22840 | |1;audio-beat-detection;157;132;131;226;133;132;157;130;168;136 15:26:18 INFO - PROCESS | 22840 | |2;audio-dft;162;162;162;163;163;162;163;163;162;161 15:26:18 INFO - PROCESS | 22840 | |3;audio-fft;76;75;76;138;77;78;75;76;120;75 15:26:18 INFO - PROCESS | 22840 | |4;audio-oscillator;93;94;159;92;95;94;131;94;93;133 15:26:18 INFO - PROCESS | 22840 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;118;117;117 15:26:18 INFO - PROCESS | 22840 | |6;imaging-darkroom;146;147;147;147;147;146;146;147;145;148 15:26:18 INFO - PROCESS | 22840 | |7;imaging-desaturate;94;95;94;94;95;94;98;94;94;94 15:26:18 INFO - PROCESS | 22840 | |8;json-parse-financial;65;65;67;64;65;68;65;68;65;68 15:26:18 INFO - PROCESS | 22840 | |9;json-stringify-tinderbox;65;65;64;64;65;65;64;65;66;65 15:26:18 INFO - PROCESS | 22840 | |10;stanford-crypto-aes;83;84;89;83;84;83;84;88;160;84 15:26:18 INFO - PROCESS | 22840 | |11;stanford-crypto-ccm;133;132;133;139;130;129;130;129;153;132 15:26:18 INFO - PROCESS | 22840 | |12;stanford-crypto-pbkdf2;181;174;176;171;171;174;171;178;172;172 15:26:18 INFO - PROCESS | 22840 | |13;stanford-crypto-sha256-iterative;69;69;71;68;67;67;67;66;66;65 15:26:18 INFO - PROCESS | 22840 | __end_tp_report 15:26:18 INFO - PROCESS | 22840 | __start_cc_report 15:26:18 INFO - PROCESS | 22840 | _x_x_mozilla_cycle_collect,2114 15:26:18 INFO - PROCESS | 22840 | __end_cc_report 15:26:18 INFO - PROCESS | 22840 | __startTimestamp1464042378063__endTimestamp 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | ------- Summary: start ------- 15:26:18 INFO - PROCESS | 22840 | Number of tests: 14 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.64 (1.4%) stddev-sans-first:1.73 15:26:18 INFO - PROCESS | 22840 | Values: 114.0 110.0 115.0 115.0 116.0 114.0 113.0 113.0 113.0 114.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:146.50 stddev:29.98 (20.5%) stddev-sans-first:31.70 15:26:18 INFO - PROCESS | 22840 | Values: 157.0 132.0 131.0 226.0 133.0 132.0 157.0 130.0 168.0 136.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 15:26:18 INFO - PROCESS | 22840 | Values: 162.0 162.0 162.0 163.0 163.0 162.0 163.0 163.0 162.0 161.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#3] audio-fft Cycles:10 Average:86.60 Median:76.00 stddev:22.77 (30.0%) stddev-sans-first:23.82 15:26:18 INFO - PROCESS | 22840 | Values: 76.0 75.0 76.0 138.0 77.0 78.0 75.0 76.0 120.0 75.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.50 stddev:24.08 (25.8%) stddev-sans-first:24.94 15:26:18 INFO - PROCESS | 22840 | Values: 93.0 94.0 159.0 92.0 95.0 94.0 131.0 94.0 93.0 133.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 15:26:18 INFO - PROCESS | 22840 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 15:26:18 INFO - PROCESS | 22840 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 145.0 148.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.26 (1.3%) stddev-sans-first:1.32 15:26:18 INFO - PROCESS | 22840 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 98.0 94.0 94.0 94.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:1.56 (2.4%) stddev-sans-first:1.62 15:26:18 INFO - PROCESS | 22840 | Values: 65.0 65.0 67.0 64.0 65.0 68.0 65.0 68.0 65.0 68.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 15:26:18 INFO - PROCESS | 22840 | Values: 65.0 65.0 64.0 64.0 65.0 65.0 64.0 65.0 66.0 65.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:84.00 stddev:23.92 (28.5%) stddev-sans-first:25.13 15:26:18 INFO - PROCESS | 22840 | Values: 83.0 84.0 89.0 83.0 84.0 83.0 84.0 88.0 160.0 84.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:132.50 stddev:7.29 (5.5%) stddev-sans-first:7.72 15:26:18 INFO - PROCESS | 22840 | Values: 133.0 132.0 133.0 139.0 130.0 129.0 130.0 129.0 153.0 132.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:174.00 stddev:3.40 (2.0%) stddev-sans-first:2.49 15:26:18 INFO - PROCESS | 22840 | Values: 181.0 174.0 176.0 171.0 171.0 174.0 171.0 178.0 172.0 172.0 15:26:18 INFO - PROCESS | 22840 | 15:26:18 INFO - PROCESS | 22840 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.78 (2.6%) stddev-sans-first:1.80 15:26:18 INFO - PROCESS | 22840 | Values: 69.0 69.0 71.0 68.0 67.0 67.0 67.0 66.0 66.0 65.0 15:26:18 INFO - PROCESS | 22840 | -------- Summary: end -------- 15:26:18 INFO - PROCESS | 22840 | 15:26:19 INFO - TEST-INFO | 22840: exit 0 15:26:19 INFO - TEST-OK | kraken | took 65631ms 15:26:19 INFO - SUITE-END | took 1184s 15:26:19 INFO - Completed test suite (00:19:44) 15:26:19 INFO - javascript benchmark 15:26:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2654.0976068136833, 2677.5849743289773, 2720.102366219148, 2728.045184185535, 2729.1403207989474, 4555.88610284743, 4628.0, 4703.835365762199, 4784.354112194857, 4837.298591704201, 4672.602828759559, 4692.648051396141, 4728.125296820082, 4738.028704115656, 4756.0, 4286.421333120028, 4340.370646256291, 4374.278244089722, 4412.3602077698715, 4529.750863702495, 4462.1968045751755, 4485.2599321111975, 4487.259602165639, 4516.887077823064, 4537.7277363358135, 4305.784710764449, 4366.279563871957, 4368.781560921973, 4407.427034485529, 4413.58070983256, 4332.025294308787, 4352.455943007124, 4363.541828108035, 4372.715773474714, 4423.668224883147, 4380.3210502372185, 4386.517483076859, 4393.692441529094, 4403.493598236179, 4440.733555986619, 4579.335996280554, 4643.117807616542, 4710.3641008463765, 4771.260454629503, 4771.427428708543, 5085.466026067246, 5108.948910510921, 5160.974195129038, 5163.096458119814, 5168.638195326329, 5126.487351264881, 5183.170692689152, 5193.662411943249, 5194.6883187008525, 5199.974000129975, 4633.907321853544, 4683.039976804746, 4723.456802467692, 4773.260144677546, 4827.565519103297, 5177.689338639693, 5186.066508028591, 5193.974030129901, 5240.633155679066, 5256.0, 5002.674826136289, 5004.449510553836, 5028.924566131511, 5046.243063540425, 5052.418971818214, 4980.5019498049905, 5038.6976781392505, 5091.847244582668, 5096.490350964874, 5123.6157288202785, 5055.443901170868, 5056.696598204119, 5069.847904562869, 5074.517920797518, 5131.999260144236, 5046.243063540498, 5047.990401919631, 5052.469490703424, 5056.191009438546, 5057.747112644353, 4162.91674166515, 4195.454590903163, 4238.36424536322, 4282.721623094489, 4286.142771445723, 3743.5694895086867, 3756.3238617048646, 3790.962090379061, 3798.012516745666, 3804.7907365094634, 4418.64650827933, 4429.069895322018, 4433.556644335606, 4473.821047158077, 4482.282834746425, 4958.702477851269, 5118.206677964921, 5132.640715149978, 5142.357205349332, 5142.408623008402, 4450.866474005785, 4471.217536931024, 4474.32885067236, 4491.281394976788, 4519.88700282489, 4616.76916154191, 4620.722756634613, 4627.467841198305, 4627.652926030494, 4673.439187297546, 4738.194506933761, 4806.351142595845, 4818.349522814376, 4842.346283251716, 4885.682430642068, 5057.115004874058, 5091.9490805092955, 5099.5665368442615, 5106.795728170831, 5117.334746482933, 4812.181929071996, 4812.807487700453, 4820.060088282751, 4829.203181475017, 4832.903341933212, 4915.926261106015, 4970.080535101018, 5001.399832020181, 5018.1469150245275, 5054.69671819692, 5084.898302033865, 5104.336436263262, 5106.285120083117, 5120.743962801919, 5168.457311982338, 4795.352627395257, 4962.404511458648, 4965.975170124127, 4976.825811096739, 4981.6014718823135, 4928.728919909439, 4969.801207951641, 4975.502449754996, 4975.975120124376, 4991.650584459053, 4919.188333925005, 4926.556609905126, 4971.552560269593, 4975.203967365204, 4977.751112444435, 4846.200376937766, 4916.237983112624, 5038.722870242172, 5084.745762711776, 5092.541671249605, 4853.053654537332, 4866.343043689199, 4879.780409881493, 4886.315915771866, 4914.140025495452], "value": 4683.884692527106, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.9516885331312, 573.9856503587413, 576.8500189950613, 579.3192998227088, 600.4145957691252, 40736.38895416571, 40760.388594171076, 41822.16355672885, 41829.58170418295, 41833.58166418335, 41260.58739412605, 41920.0, 41945.0, 42007.369889451686, 42028.36957445633, 7376.409887209037, 7696.73061442851, 7904.644291006918, 9927.354721943087, 10011.299209055369, 9764.316497845153, 10065.396076235413, 10070.04334588213, 10088.949555252213, 10089.394636321807, 10093.747656308578, 10165.440900750456, 10174.491275436236, 10177.898221017806, 10184.439855807928, 10017.649382271622, 10102.343347682377, 10103.696889093339, 10105.848412273821, 10109.39343639384, 9934.701958941243, 10001.199904007735, 10031.849522257173, 10038.0, 10039.598416063349, 37698.246035079144, 38066.42900356497, 38103.23793524114, 38122.42816357757, 38151.61848381509, 3191.5372271020806, 3387.7459190560808, 3436.1409647588102, 3620.601733809279, 3856.093817952779, 29431.11706648804, 29613.555796663066, 30325.24186895323, 31953.36093278145, 32013.519797203062, 3536.257385948954, 3545.62770909056, 3567.30437564675, 3567.4470457079196, 3595.5505561804775, 272556.0, 273411.632941836, 273860.0, 275226.0, 276227.0, 54850.72574637101, 55177.448225518034, 55210.723946380815, 55258.0, 55290.894182116936, 58863.70568147132, 59093.113603295984, 59172.40827591669, 59179.70410147922, 59204.40795591989, 11855.585054523222, 12153.817692734616, 12174.269543827399, 12209.755804883853, 12221.877781222074, 9498.287628427895, 9540.0, 9550.952245238868, 9553.140217380469, 9558.187554057844, 17926.28255949719, 18728.625427491374, 18769.24923003092, 18934.147963341682, 19123.71314430285, 6816.216135144423, 6845.452363810883, 6996.0, 7106.751263705745, 7153.391961683211, 915.272358475014, 963.6145541783203, 966.5119114846957, 995.9253056020827, 1005.5374527717186, 27987.160385188476, 28475.572866406605, 28478.857605712252, 29013.0, 29140.27149321284, 951.9809603808023, 961.3462845265286, 975.4683697384942, 975.9658411955547, 1035.1253191053547, 14839.40642374293, 15065.698686026219, 15100.39598416073, 15296.158711270764, 15520.767188492182, 404160.0, 405237.0, 410998.0, 411662.0, 412523.0, 49254.75372623186, 49521.0, 49917.0, 49951.25073123906, 49952.0, 1197.7944743068108, 1216.5255550335376, 1236.3756303067073, 1238.4365113872987, 1239.2440611227144, 26195.214143575722, 27400.58899116475, 27883.16350509488, 27992.860035700505, 28089.0, 42898.35652465278, 42950.570494294654, 43083.0, 43147.352789708806, 43272.0, 329902.0, 330649.0, 330845.0, 331526.0, 332161.0, 21970.34088977333, 21976.34070977873, 22556.210532631278, 24692.0, 25066.3733406659, 37202.627973721, 37242.62757372392, 37311.2537749238, 42842.1431571373, 43621.0, 36194.276114477034, 36218.63781362153, 36831.63168368282, 36918.26163476662, 37207.25585488329, 35988.0, 36445.0, 36753.816230918674, 36996.0, 37299.62700372961, 36398.8180059098, 37264.627353726115, 37610.435843461826, 38607.61392386153, 39121.6087839118, 31603.36793264076, 33896.491552626234, 33964.49053264252, 34008.31983360369, 34078.82960585181, 25168.0, 27180.592291116045, 27349.453010939273, 27422.177334679993, 27456.725432745417], "value": 18324.57072813624, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.4530032301386, 366.55463611711764, 366.7909291703728, 377.99244015119683, 381.9732618716689, 15827.841721582796, 16997.745033824503, 17051.0, 17489.7376539352, 17511.562210944732, 16311.347546098143, 16789.41237056703, 17389.739153912702, 17449.302027918868, 17507.82492175078, 5072.670276432039, 5211.035958347698, 5217.452167522412, 5255.211718242256, 5261.579073674096, 3786.734928555002, 3994.6005399460114, 5181.9740901295445, 5721.427857214266, 6052.334243233241, 6058.303295121052, 6095.055266433687, 6114.847128821771, 6122.877542449149, 6124.724387402578, 5983.58114931955, 6028.4574388305045, 6107.206063211754, 6112.205413296265, 6136.723847426876, 3434.4848272759036, 4993.475685053054, 5305.230741542493, 5318.574514038867, 5359.38367087786, 19676.311329103555, 20293.0, 20373.694394584094, 20457.2839950601, 20465.18139274442, 2183.170395249811, 2278.532900755358, 2334.8482348647285, 2524.6213068039756, 2549.4901019796116, 12531.749365012649, 12871.678208044781, 13124.606261812161, 13325.268924701099, 13515.864841351558, 1724.3619860651513, 1814.165483877418, 1818.4181062060145, 1819.8362147406665, 1825.6074943886995, 65882.3411765881, 68388.6580567099, 68541.0, 68798.65600672015, 68856.6557167221, 9551.331406801597, 9572.76068098303, 9863.260255480867, 9884.752881178028, 10081.747956301151, 13545.1195672281, 13576.592702218752, 13622.93188534051, 13663.18020918748, 13685.589432317047, 6529.11856899322, 6565.80302590923, 6603.141591593062, 6686.231083425469, 6705.463562914955, 5721.885562288731, 5802.506786923159, 6029.547783916224, 6058.636481811105, 6169.56813023084, 5958.344582095966, 6077.24034495688, 6090.482309003784, 6272.905906411407, 6363.9045414318825, 1519.308714534884, 1637.90172589645, 1711.4523352527071, 1743.1894169211123, 1778.6264884374427, 820.2781552233996, 872.5549969515466, 894.6555576103248, 922.1378011559214, 992.8212921674024, 16820.6635867282, 17751.378701745634, 17753.0, 18432.275800579486, 18561.53596160107, 898.0, 910.8497097978759, 912.183595681861, 923.072312326108, 971.0338213477635, 10158.0, 10434.37393756377, 10437.217208709377, 10458.26792124544, 10540.789184216273, 361392.0, 361990.0, 362653.0, 363598.0, 385580.0, 73890.26109738834, 74937.0, 75530.0, 76106.85839712409, 77727.22272777313, 947.332130847737, 948.1561410344799, 949.6296444386695, 952.1620973543238, 953.1564565359567, 16148.434804781777, 16237.67524649524, 16291.0, 16447.506574802774, 16451.91774041122, 24939.0, 26695.33261668474, 29888.402231955675, 34425.139371515914, 34565.65434345624, 30588.694113059475, 46402.30396543987, 46930.29604555866, 47975.5202447985, 48080.5191948076, 6346.270178929298, 6408.423241908251, 6805.183377994672, 6841.076454678555, 7877.724279650185, 7394.963025185055, 10096.19230461576, 10353.689389318333, 10373.792524149323, 10575.471226438802, 6432.067350234096, 8879.534876745265, 8953.641854326015, 9042.276617870686, 9272.119148680864, 9208.447493150432, 9268.53657317145, 9329.72010839676, 9348.252139828934, 9487.57305921249, 9147.725568232963, 9463.195628371666, 9629.470379129216, 9641.842978842584, 9722.27082968766, 6788.151481064867, 6811.080504131879, 6819.215790183994, 6894.724211031503, 7055.435565154673, 8559.63045912651, 9832.803343933225, 9913.355631883904, 9975.50122493887, 10122.898771012196], "value": 8147.430615645317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1126.6169502369194, 1417.305520295055, 1428.2073449235672, 1532.923353832308, 1727.50766031681, 6542.803715888519, 7546.7358642447525, 7778.9222107778905, 7786.299233069023, 7982.720604778834, 7651.0, 7769.689212431496, 7792.3376512996465, 7803.219678032194, 7812.492188007775, 2104.358170757922, 2125.4792575818947, 2129.6273152198382, 2134.2743467221144, 2134.7011418401435, 2067.865588736735, 2119.6502577074843, 2178.106976139783, 2178.477165480281, 2181.55278167976, 2173.434906924203, 2190.145843121184, 2198.824094072478, 2200.9559808803815, 2214.6345852934246, 2110.303599812066, 2119.788021197883, 2121.2151503943487, 2121.575684863026, 2122.108714339981, 2103.8737675739503, 2157.557700671359, 2161.070739581979, 2163.2212403534713, 2165.07984106754, 7574.5076570022775, 7703.0, 7720.729774457867, 7792.064952205715, 7815.882761758578, 4318.52496225415, 4490.865274041784, 4493.505714371417, 4496.190685676577, 4497.550244975509, 2971.4948458762065, 2976.226181192884, 3037.3773376457775, 3040.6807285234954, 3050.8932187373557, 922.8800255966748, 949.2026697574001, 952.8570714392896, 958.1328897347911, 972.246508955558, 10749.140068794555, 10810.621628242974, 10843.349399036004, 10848.18638602108, 10855.294405863593, 3929.2337994090876, 4100.2619528484565, 4159.771212583337, 4170.854020109342, 4179.832806687759, 8505.192006759347, 8572.742817715478, 8585.914140858511, 8587.785305367292, 8603.913960860436, 4375.934360984587, 4408.603225709701, 4418.226810308183, 4418.270985287456, 4421.248387774086, 3448.3103379324234, 3785.981070094687, 3951.130751234724, 4018.3972404139613, 4080.6327430531396, 3404.7957122572725, 3411.846466908995, 3510.526078979356, 3512.5960514540643, 3526.3828829954655, 976.5947131940165, 976.7411635916487, 985.2167526816198, 1013.7668336282696, 1015.1726343030407, 836.9204925532065, 842.6629348260744, 843.5529169540154, 845.1843970568431, 869.8564736818354, 4855.271709243571, 5179.792808287626, 5268.868278293074, 5341.786328546892, 5367.490088441592, 867.5445391169686, 883.7081870034071, 891.0910870911633, 908.981820363589, 909.1408618855119, 3501.9474707879403, 3594.478800573902, 3625.4018087015875, 3836.271108489378, 3976.880693579197, 9696.224302055818, 9787.804243915081, 9890.456024918698, 9899.703008909744, 9902.158316543031, 9715.319927605, 9873.259505537113, 9885.209183265322, 9900.653477128266, 9914.305998580174, 7163.498555101197, 7226.566406015656, 7251.419886409075, 7403.037605111301, 7407.0, 5271.7891284349735, 5330.067238233371, 5357.089294819968, 5398.40617532079, 5403.83788486346, 8795.780105497413, 8838.646454141763, 9063.456192628464, 9091.090890910857, 9104.590293436944, 9043.412178208395, 9116.179543841086, 9149.0, 9175.632974681204, 9251.583678734338, 5893.410658934073, 6473.579217350857, 6660.467162627075, 6690.264070952288, 6807.761728339682, 7692.076950765944, 7728.188540203198, 7764.6894124234395, 7766.223377662189, 7780.92219077802, 6680.532362734756, 6767.89848152288, 6771.830704232433, 6980.7905762827195, 7013.719451221894, 6514.283428822731, 6516.967415162894, 6539.182602174728, 6592.472602191909, 6602.8349291268105, 6328.335524769833, 6330.240371155491, 6356.555041147075, 6378.266499352634, 6445.097686324012, 4543.772811359353, 4754.857354279377, 4775.5463230993, 4828.444728856086, 4866.075445665312, 4681.836135735233, 4717.0, 4774.092922344744, 4811.807527698993, 4862.562369386772], "value": 4110.775583742359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.72051228259454, 282.5054081017809, 288.44474386805393, 291.125168867553, 292.2809887676317, 4662.370579971703, 4805.159097157996, 4808.687435316702, 4834.178189707749, 4871.220604703248, 4627.976860115703, 4765.856194513318, 4778.928316075253, 4811.374521312233, 4812.542808433193, 3814.542254929412, 3815.9618403815884, 3821.6751576115926, 3821.9617803821884, 3832.0, 3608.8376023078895, 3674.7060235181257, 3799.278137153946, 3824.5028146340937, 3829.942550861739, 3747.4378843173467, 3756.530433695788, 3790.185110201306, 3795.7153213509096, 3799.886003419902, 3755.3052685253315, 3772.2832661794446, 3777.26245926874, 3778.471014058034, 3787.14789172434, 3363.461846104636, 3382.6448222936483, 3387.7967321960514, 3389.7288216942834, 3424.7945123292684, 4492.393526873863, 4578.244589642738, 4598.977005114953, 4612.3542704021465, 4613.261878099488, 4290.485141782975, 4297.806598703066, 4303.763293018883, 4309.1381723655395, 4310.655147588185, 4741.786619602126, 4883.362983988642, 4935.851924442272, 4941.382327209099, 4956.2565615157655, 3519.331327047853, 3525.7355698322726, 3530.2057037166687, 3532.876349327761, 3543.3799085159994, 5185.481451854822, 5203.4796520348045, 5206.7917283308625, 5215.869603259911, 5218.842600226884, 3605.8737944172353, 3608.296382205445, 3610.5125808016105, 3620.5474315710535, 3624.257027309395, 3452.8273586320583, 3671.430928206079, 3697.6117507661306, 3698.816378758825, 3701.444783282529, 4210.831566737357, 4214.894627634334, 4221.662267018631, 4222.809973551136, 4242.766647834337, 4769.785359658824, 4971.130052240916, 5022.974885125551, 5036.924446133311, 5038.496150385005, 1243.3348158735214, 1273.2933222061845, 1283.9422225999851, 1287.2598256002836, 1290.5160564788205, 787.4173111897269, 801.3669201330883, 813.9267465928095, 820.335528222142, 822.942394032424, 3993.4608827807874, 3997.1413292818397, 3998.620131087542, 4029.879103626896, 4034.2536630722825, 4559.540946896961, 4561.680682352204, 4570.514582760616, 4587.816487340469, 4590.908181836345, 3951.0, 3989.6608788253325, 3989.8204580793936, 3989.960100399017, 4036.919261614751, 2330.4290448840143, 2417.16607770319, 2417.504411595619, 2450.877456127222, 2451.987740061324, 4312.805923733439, 4353.36876152956, 4354.760488173118, 4364.4980827204645, 4399.5820397062225, 4620.2607582786595, 4652.418447694038, 4662.4405071390975, 4664.6239359389065, 4671.95328046722, 4166.729162604482, 4352.8041238145, 4368.650507959355, 4379.664202418229, 4383.627391671744, 4490.685652004328, 4534.501204867396, 4555.24623020133, 4560.315952607136, 4573.977130114461, 4398.69209155356, 4447.532314336197, 4449.354843547732, 4481.126180394792, 4489.530758082976, 4151.398047283187, 4332.988572941776, 4356.411884395566, 4370.344448332648, 4375.337371798696, 3313.5526703894666, 3316.585426821647, 3331.500824628878, 3337.2824842658947, 3342.4819153031317, 4495.865124046284, 4568.291914753218, 4607.124646317189, 4635.629149667951, 4966.801327946841, 4807.903841923072, 4996.150654388835, 5022.673526220784, 5071.7827721345875, 5075.086484432837, 4971.577415919687, 4992.400911890596, 5003.249512573143, 5020.820107274714, 5029.295898574275, 4742.115620910467, 4922.852314430573, 4941.160002799461, 4943.307936888767, 4945.653804233669, 5018.874528136826, 5037.924431133462, 5050.646454748133, 5056.191009438472, 5068.670536415121, 4940.827071052496, 4943.530364615356, 4963.70217786934, 4993.650444468997, 5003.299538064746], "value": 3633.0151840791764, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.7506097804791, 716.0476566166999, 726.5241266970133, 770.3182683325256, 777.2654841175084, 11718.882811171885, 12508.874911250896, 12515.24908505488, 12539.373031348441, 12544.059195560323, 12242.57150999713, 12260.509579616804, 12262.264264144158, 12292.201006934543, 12305.261684298948, 622.2377587455354, 775.6393277126135, 804.4047404920346, 805.8509175802466, 808.6118663041714, 802.1136644008375, 807.4267270238138, 811.2860682599304, 811.8660421030523, 811.8741595052776, 660.3561527510686, 843.5402705525503, 844.9155084491563, 846.0, 846.5894041389952, 828.8715249136394, 853.7993571510659, 855.0936007831718, 857.9099194584542, 858.2576071697937, 606.0333767640606, 609.9969500152515, 614.5206738743786, 614.9169862068653, 615.1019511513151, 12520.499180032788, 12548.247105173628, 12570.497180112785, 12582.68543286416, 12594.496220151183, 12454.377281135998, 12863.807042894365, 12889.162204456774, 13013.934930325382, 13208.825815710197, 9726.124648781644, 9884.703458896245, 9896.653617123366, 10079.44563049032, 10202.540885660163, 3319.850606722703, 3344.2642618623863, 3387.5257463955068, 3398.3882901077795, 3471.9410579773157, 47281.290780638315, 48073.519264807255, 48150.759246203896, 48244.51755482436, 48442.27336589989, 10198.949005254926, 10220.0, 10241.692749217535, 10362.637307694346, 10372.688819335432, 18390.356337528123, 18441.53896152607, 18477.0, 18501.44495665132, 18524.536886577942, 6788.287229840895, 6812.523123381316, 6835.282295359015, 6975.0, 7032.437405007587, 3614.2229420674157, 3676.8713095041544, 3697.759645623026, 3714.981425092857, 3764.0401697567495, 2712.0778935161743, 2732.3715545424666, 2803.1170181393204, 2806.116073436861, 2834.5039618067167, 407.60055145956534, 512.8743457852776, 517.9326687530597, 540.7485519233576, 546.3498436860124, 472.9929051064237, 549.2420459765498, 595.5503594785908, 632.7500637248261, 641.7433026789322, 8367.748967530984, 8413.242808147295, 8648.654053837776, 8809.207171354608, 8872.512011839412, 601.7412512619528, 602.7890238416519, 616.3066550131102, 617.4844005255572, 621.1645337021698, 3801.904952376213, 3926.0773718176206, 3945.585713500099, 4007.8196481158416, 4020.537638171589, 55273.44726552763, 56385.7180714102, 56423.43576564264, 57033.714831425576, 57093.714531427075, 49300.26049609187, 50463.24305135426, 50647.74676126596, 50667.23999140016, 52970.0, 47157.29264060973, 47549.5245047552, 47741.761291193325, 47940.28089578659, 48674.75662621735, 7637.656305466378, 7641.465097443125, 7790.961045194737, 7833.5691536966015, 7874.1338452769005, 32201.838990805834, 32412.189695257806, 32632.510512342807, 32737.508937366434, 32826.83586582052, 38050.80974595109, 40528.0, 41743.16513669649, 41874.37188442115, 42474.0, 9836.557354919189, 9885.851712224467, 9920.355176913477, 9943.30396872212, 10050.798984020425, 9787.804243915225, 11026.669199924016, 11141.498632561392, 11225.101991840796, 11573.826392604286, 11059.557617695524, 11170.944145279222, 11198.832017519906, 11567.132465065322, 11619.47712352963, 11357.375344355809, 11498.532894442966, 11657.06743460538, 11678.474468649101, 11742.236754610924, 11077.0, 11122.388268645302, 11134.832977505506, 11140.442977851237, 11200.607978720705, 9318.43207988086, 9346.672866449642, 9359.532023398666, 9693.030696930533, 9708.126268635575, 9761.17030052425, 9928.305018648625, 9933.304668673123, 9947.701568952943, 10034.799304014025], "value": 6042.281895512338, "unit": "score"}], "name": "dromaeo_css", "value": 6309.831193101315, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 115.0, 115.0, 116.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 132.0, 131.0, 226.0, 133.0, 132.0, 157.0, 130.0, 168.0, 136.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 163.0, 162.0, 163.0, 163.0, 162.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 138.0, 77.0, 78.0, 75.0, 76.0, 120.0, 75.0], "value": 86.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 159.0, 92.0, 95.0, 94.0, 131.0, 94.0, 93.0, 133.0], "value": 107.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 145.0, 148.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 98.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 64.0, 65.0, 68.0, 65.0, 68.0, 65.0, 68.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 66.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 89.0, 83.0, 84.0, 83.0, 84.0, 88.0, 160.0, 84.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 133.0, 139.0, 130.0, 129.0, 130.0, 129.0, 153.0, 132.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 174.0, 176.0, 171.0, 171.0, 174.0, 171.0, 178.0, 172.0, 172.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 65.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1577.3, "alertThreshold": 2.0}]} 15:26:19 INFO - Return code: 0 15:26:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:26:19 ERROR - # TBPL SUCCESS # 15:26:19 INFO - Running post-action listener: _resource_record_post_action 15:26:19 INFO - ##### 15:26:19 INFO - ##### Finished run-tests step (success) 15:26:19 INFO - ##### 15:26:19 INFO - Running post-run listener: _resource_record_post_run 15:26:19 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533700608; Read time: 12; Write time: 678936 15:26:19 INFO - TinderboxPrint: CPU usage
13.2% 15:26:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:26:19 INFO - TinderboxPrint: I/O write bytes / time
533,700,608 / 678,936 15:26:19 INFO - TinderboxPrint: CPU idle
8,318.4 (86.8%) 15:26:19 INFO - TinderboxPrint: CPU user
1,220.1 (12.7%) 15:26:19 INFO - TinderboxPrint: Swap in / out
0 / 0 15:26:19 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 240701440; Read time: 0; Write time: 411864 15:26:19 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292999168; Read time: 12; Write time: 267072 15:26:19 INFO - Running post-run listener: _upload_blobber_files 15:26:19 INFO - Blob upload gear active. 15:26:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:26:19 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 15:26:19 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'] 15:26:19 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 15:26:20 INFO - (blobuploader) - INFO - Open directory for files ... 15:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:23 INFO - (blobuploader) - INFO - Done attempting. 15:26:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:26:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:24 INFO - (blobuploader) - INFO - Done attempting. 15:26:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:26:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:26:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:25 INFO - (blobuploader) - INFO - Done attempting. 15:26:25 INFO - (blobuploader) - INFO - Iteration through files over. 15:26:25 INFO - Return code: 0 15:26:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:26:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:26:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7fd1eeee62875e2eab0e76f9d0c4707612b4d179ea03cc8ceab72aa4bba260261823bd9d87b92dc3ced3f068625aea16679aca0a5f0cdc65c3fd71361807227", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60a7a5c0428b9b30046e9fac22685302a872236f8da9bf73a8345c55bc59ba9064b43cac4976f45a77e240f4f187cb86f3b78494a443618533ae96736e9fc99d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5fc5940b97f3e757efcb9d87192d65f88a0c61e6abde8544cad69dc4297d5053f0135591516cdd4f853027a62a8266f120f01d9e29b1190f71f5a120fc158f7"} 15:26:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:26:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:26:25 INFO - Contents: 15:26:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7fd1eeee62875e2eab0e76f9d0c4707612b4d179ea03cc8ceab72aa4bba260261823bd9d87b92dc3ced3f068625aea16679aca0a5f0cdc65c3fd71361807227", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60a7a5c0428b9b30046e9fac22685302a872236f8da9bf73a8345c55bc59ba9064b43cac4976f45a77e240f4f187cb86f3b78494a443618533ae96736e9fc99d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5fc5940b97f3e757efcb9d87192d65f88a0c61e6abde8544cad69dc4297d5053f0135591516cdd4f853027a62a8266f120f01d9e29b1190f71f5a120fc158f7"} 15:26:25 INFO - Running post-run listener: copy_logs_to_upload_dir 15:26:25 INFO - Copying logs to upload dir... 15:26:25 INFO - mkdir: /builds/slave/test/build/upload/logs 15:26:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.391835 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-23 15:26:24.329946) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 15:26:24.333105) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7fd1eeee62875e2eab0e76f9d0c4707612b4d179ea03cc8ceab72aa4bba260261823bd9d87b92dc3ced3f068625aea16679aca0a5f0cdc65c3fd71361807227", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60a7a5c0428b9b30046e9fac22685302a872236f8da9bf73a8345c55bc59ba9064b43cac4976f45a77e240f4f187cb86f3b78494a443618533ae96736e9fc99d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5fc5940b97f3e757efcb9d87192d65f88a0c61e6abde8544cad69dc4297d5053f0135591516cdd4f853027a62a8266f120f01d9e29b1190f71f5a120fc158f7"} build_url:https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/Jo1aJFlfQi-p8JxAE57X8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7fd1eeee62875e2eab0e76f9d0c4707612b4d179ea03cc8ceab72aa4bba260261823bd9d87b92dc3ced3f068625aea16679aca0a5f0cdc65c3fd71361807227", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60a7a5c0428b9b30046e9fac22685302a872236f8da9bf73a8345c55bc59ba9064b43cac4976f45a77e240f4f187cb86f3b78494a443618533ae96736e9fc99d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5fc5940b97f3e757efcb9d87192d65f88a0c61e6abde8544cad69dc4297d5053f0135591516cdd4f853027a62a8266f120f01d9e29b1190f71f5a120fc158f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 15:26:24.359951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 15:26:24.360482) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1464041141.571256-570824223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 15:26:24.441581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 15:26:24.441906) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 15:26:24.442196) ========= ========= Total master_lag: 0.15 =========