builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1463151272.92 results: success (0) buildid: 20160513071835 builduid: 2ac532df4ff148aa82ac26222b16cf13 revision: cc0133021748b050a03cb242dfa4af51a3a46112 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:32.920675) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:32.921095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:32.921590) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:32.954036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:32.954366) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 07:54:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-05-13 07:54:33 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123174 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:33.093905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:33.094234) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020353 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:33.142894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:33.143203) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cc0133021748b050a03cb242dfa4af51a3a46112 --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 cc0133021748b050a03cb242dfa4af51a3a46112 --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=e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 07:54:33,303 truncating revision to first 12 chars 2016-05-13 07:54:33,303 Setting DEBUG logging. 2016-05-13 07:54:33,303 attempt 1/10 2016-05-13 07:54:33,303 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cc0133021748?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 07:54:33,536 unpacking tar archive at: fx-team-cc0133021748/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538413 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:33.694762) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:33.695071) ========= script_repo_revision: cc0133021748b050a03cb242dfa4af51a3a46112 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:33.695475) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:33.695741) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 07:54:33.705812) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-13 07:54:33.706159) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:54:33 INFO - MultiFileLogger online at 20160513 07:54:33 in /builds/slave/test 07:54:33 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 07:54:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:54:33 INFO - {'append_to_log': False, 07:54:33 INFO - 'base_work_dir': '/builds/slave/test', 07:54:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:54:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:54:33 INFO - 'branch': 'Fx-Team-Non-PGO', 07:54:33 INFO - 'buildbot_json_path': 'buildprops.json', 07:54:33 INFO - 'config_files': ('talos/linux_config.py',), 07:54:33 INFO - 'default_actions': ('clobber', 07:54:33 INFO - 'read-buildbot-config', 07:54:33 INFO - 'download-and-extract', 07:54:33 INFO - 'populate-webroot', 07:54:33 INFO - 'create-virtualenv', 07:54:33 INFO - 'install', 07:54:33 INFO - 'run-tests'), 07:54:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:54:33 INFO - 'download_minidump_stackwalk': True, 07:54:33 INFO - 'download_symbols': 'ondemand', 07:54:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:54:33 INFO - 'tooltool.py': '/tools/tooltool.py', 07:54:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:54:33 INFO - '/tools/misc-python/virtualenv.py')}, 07:54:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:54:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:54:33 INFO - 'installer_path': 'installer.exe', 07:54:33 INFO - 'log_level': 'info', 07:54:33 INFO - 'log_name': 'talos', 07:54:33 INFO - 'log_to_console': True, 07:54:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:54:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:54:33 INFO - 'opt_config_files': (), 07:54:33 INFO - 'pip_index': False, 07:54:33 INFO - 'sps_profile': False, 07:54:33 INFO - 'sps_profile_interval': 0, 07:54:33 INFO - 'suite': 'dromaeojs', 07:54:33 INFO - 'system_bits': '32', 07:54:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:54:33 INFO - 'title': 'talos-linux64-ix-067', 07:54:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:54:33 INFO - 'use_talos_json': True, 07:54:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:54:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:54:33 INFO - 'work_dir': 'build'} 07:54:33 INFO - ##### 07:54:33 INFO - ##### Running clobber step. 07:54:33 INFO - ##### 07:54:33 INFO - Running pre-action listener: _resource_record_pre_action 07:54:33 INFO - Running main action method: clobber 07:54:33 INFO - rmtree: /builds/slave/test/build 07:54:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:54:34 INFO - Running post-action listener: _resource_record_post_action 07:54:34 INFO - ##### 07:54:34 INFO - ##### Finished clobber step (success) 07:54:34 INFO - ##### 07:54:34 INFO - ##### 07:54:34 INFO - ##### Running read-buildbot-config step. 07:54:34 INFO - ##### 07:54:34 INFO - Running pre-action listener: _resource_record_pre_action 07:54:34 INFO - Running main action method: read_buildbot_config 07:54:34 INFO - Using buildbot properties: 07:54:34 INFO - { 07:54:34 INFO - "project": "", 07:54:34 INFO - "product": "firefox", 07:54:34 INFO - "script_repo_revision": "production", 07:54:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:54:34 INFO - "repository": "", 07:54:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:54:34 INFO - "buildid": "20160513071835", 07:54:34 INFO - "pgo_build": "False", 07:54:34 INFO - "basedir": "/builds/slave/test", 07:54:34 INFO - "buildnumber": 1683, 07:54:34 INFO - "slavename": "talos-linux64-ix-067", 07:54:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:54:34 INFO - "platform": "ubuntu64_hw", 07:54:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:54:34 INFO - "branch": "fx-team", 07:54:34 INFO - "repo_path": "integration/fx-team", 07:54:34 INFO - "revision": "cc0133021748b050a03cb242dfa4af51a3a46112", 07:54:34 INFO - "stage_platform": "linux64", 07:54:34 INFO - "builduid": "2ac532df4ff148aa82ac26222b16cf13", 07:54:34 INFO - "slavebuilddir": "test" 07:54:34 INFO - } 07:54:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:54:34 INFO - Running post-action listener: _resource_record_post_action 07:54:34 INFO - ##### 07:54:34 INFO - ##### Finished read-buildbot-config step (success) 07:54:34 INFO - ##### 07:54:34 INFO - ##### 07:54:34 INFO - ##### Running download-and-extract step. 07:54:34 INFO - ##### 07:54:34 INFO - Running pre-action listener: _resource_record_pre_action 07:54:34 INFO - Running main action method: download_and_extract 07:54:34 INFO - mkdir: /builds/slave/test/build/tests 07:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:34 INFO - https://queue.taskcluster.net/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:54:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:54:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:54:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/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 07:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/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 07:54:38 INFO - Downloaded 1361 bytes. 07:54:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:54:38 INFO - Using the following test package requirements: 07:54:38 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:54:38 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:54:38 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:54:38 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:38 INFO - u'jsshell-linux-x86_64.zip'], 07:54:38 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:54:38 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:54:38 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:54:38 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:54:38 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:54:38 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:54:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:38 INFO - https://queue.taskcluster.net/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/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 07:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/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 07:54:39 INFO - Downloaded 22334315 bytes. 07:54:39 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'] 07:54:39 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 07:54:40 INFO - Return code: 0 07:54:40 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 07:54:40 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')]} 07:54:40 INFO - https://queue.taskcluster.net/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/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 07:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/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 07:54:43 INFO - Downloaded 22334315 bytes. 07:54:43 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'] 07:54:43 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 07:54:44 INFO - Return code: 0 07:54: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')]} 07:54:44 INFO - https://queue.taskcluster.net/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:54:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:54:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:54:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/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 07:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/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 07:54:45 INFO - Downloaded 10840239 bytes. 07:54:45 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'] 07:54:45 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 07:54:45 INFO - Return code: 0 07:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:45 INFO - https://queue.taskcluster.net/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:54:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:54:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:54:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/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 07:54:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P-N-47h_TVSQhDimJ9N7jg/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 07:54:47 INFO - Downloaded 54735065 bytes. 07:54:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:54:47 INFO - mkdir: /builds/slave/test/properties 07:54:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:54:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:54:47 INFO - Contents: 07:54:47 INFO - build_url:https://queue.taskcluster.net/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:54:48 INFO - Running post-action listener: _resource_record_post_action 07:54:48 INFO - Running post-action listener: set_extra_try_arguments 07:54:48 INFO - ##### 07:54:48 INFO - ##### Finished download-and-extract step (success) 07:54:48 INFO - ##### 07:54:48 INFO - ##### 07:54:48 INFO - ##### Running populate-webroot step. 07:54:48 INFO - ##### 07:54:48 INFO - Running pre-action listener: _resource_record_pre_action 07:54:48 INFO - Running main action method: populate_webroot 07:54:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:54:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:54:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:54:48 INFO - '--tppagecycles', 07:54:48 INFO - '7'], 07:54:48 INFO - 'tests': ['tsvgm']}}, 07:54:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:54:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:54:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:54:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:54:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:54:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:54:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:48 INFO - 'talos_options': ['--disable-e10s'], 07:54:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:48 INFO - 'talos_options': ['--disable-e10s'], 07:54:48 INFO - 'tests': ['damp', 'tps']}, 07:54:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:48 INFO - 'tests': ['damp', 'tps']}, 07:54:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:54:48 INFO - 'tests': ['dromaeo_dom']}, 07:54:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:54:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:54:48 INFO - 'tests': ['a11yr', 07:54:48 INFO - 'ts_paint', 07:54:48 INFO - 'tpaint', 07:54:48 INFO - 'sessionrestore', 07:54:48 INFO - 'sessionrestore_no_auto_restore', 07:54:48 INFO - 'tabpaint']}, 07:54:48 INFO - 'other-e10s': {'tests': ['a11yr', 07:54:48 INFO - 'ts_paint', 07:54:48 INFO - 'tpaint', 07:54:48 INFO - 'sessionrestore', 07:54:48 INFO - 'sessionrestore_no_auto_restore', 07:54:48 INFO - 'tabpaint']}, 07:54:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:54:48 INFO - 'ts_paint', 07:54:48 INFO - 'tpaint', 07:54:48 INFO - 'sessionrestore', 07:54:48 INFO - 'sessionrestore_no_auto_restore', 07:54:48 INFO - 'tabpaint']}, 07:54:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:54:48 INFO - 'ts_paint', 07:54:48 INFO - 'tpaint', 07:54:48 INFO - 'sessionrestore', 07:54:48 INFO - 'sessionrestore_no_auto_restore', 07:54:48 INFO - 'tabpaint']}, 07:54:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:54:48 INFO - 'tests': ['a11yr', 07:54:48 INFO - 'ts_paint', 07:54:48 INFO - 'tpaint', 07:54:48 INFO - 'sessionrestore', 07:54:48 INFO - 'sessionrestore_no_auto_restore', 07:54:48 INFO - 'tabpaint']}, 07:54:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:54:48 INFO - 'tests': ['a11yr', 07:54:48 INFO - 'ts_paint', 07:54:48 INFO - 'tpaint', 07:54:48 INFO - 'sessionrestore', 07:54:48 INFO - 'sessionrestore_no_auto_restore', 07:54:48 INFO - 'tabpaint']}, 07:54:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:54:48 INFO - 'tests': ['tsvgx', 07:54:48 INFO - 'tsvgr_opacity', 07:54:48 INFO - 'tart', 07:54:48 INFO - 'tscrollx', 07:54:48 INFO - 'cart']}, 07:54:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:54:48 INFO - 'tsvgr_opacity', 07:54:48 INFO - 'tart', 07:54:48 INFO - 'tscrollx', 07:54:48 INFO - 'cart']}, 07:54:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:48 INFO - 'talos_options': ['--disable-e10s'], 07:54:48 INFO - 'tests': ['tp5o']}, 07:54:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:48 INFO - 'tests': ['tp5o']}, 07:54:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:48 INFO - 'talos_options': ['--disable-e10s', 07:54:48 INFO - '--xperf_path', 07:54:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:48 INFO - 'tests': ['tp5n']}, 07:54:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:48 INFO - 'talos_options': ['--xperf_path', 07:54:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:48 INFO - 'tests': ['tp5n']}}, 07:54:48 INFO - 'talos.zip': {'path': '', 07:54:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:54:48 INFO - Running post-action listener: _resource_record_post_action 07:54:48 INFO - ##### 07:54:48 INFO - ##### Finished populate-webroot step (success) 07:54:48 INFO - ##### 07:54:48 INFO - ##### 07:54:48 INFO - ##### Running create-virtualenv step. 07:54:48 INFO - ##### 07:54:48 INFO - Running pre-action listener: _resource_record_pre_action 07:54:48 INFO - Running main action method: create_virtualenv 07:54:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:54:48 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 07:54:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:54:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:54:48 INFO - Using real prefix '/usr' 07:54:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:54:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:54:51 INFO - Installing pip.................done. 07:54:51 INFO - Return code: 0 07:54:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:51 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 0x7f1060267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d119c0>, '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 0x1d128c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d12d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', '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 07:54:51 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 07:54:51 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 07:54:51 INFO - Using env: {'DISPLAY': ':0', 07:54:51 INFO - 'HOME': '/home/cltbld', 07:54:51 INFO - 'LANG': 'en_US.UTF-8', 07:54:51 INFO - 'LANGUAGE': 'en_US:en', 07:54:51 INFO - 'LOGNAME': 'cltbld', 07:54:51 INFO - 'MAIL': '/var/mail/cltbld', 07:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:51 INFO - 'MOZ_NO_REMOTE': '1', 07:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:51 INFO - 'NO_EM_RESTART': '1', 07:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:51 INFO - 'PWD': '/builds/slave/test', 07:54:51 INFO - 'SHELL': '/bin/bash', 07:54:51 INFO - 'SHLVL': '1', 07:54:51 INFO - 'TERM': 'linux', 07:54:51 INFO - 'TMOUT': '86400', 07:54:51 INFO - 'USER': 'cltbld', 07:54:51 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', 07:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:51 INFO - '_': '/tools/buildbot/bin/python'} 07:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:51 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 07:54:51 INFO - Cleaning up... 07:54:51 INFO - Return code: 0 07:54:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:51 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 0x7f1060267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d119c0>, '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 0x1d128c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d12d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', '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 07:54:51 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 07:54:51 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 07:54:51 INFO - Using env: {'DISPLAY': ':0', 07:54:51 INFO - 'HOME': '/home/cltbld', 07:54:51 INFO - 'LANG': 'en_US.UTF-8', 07:54:51 INFO - 'LANGUAGE': 'en_US:en', 07:54:51 INFO - 'LOGNAME': 'cltbld', 07:54:51 INFO - 'MAIL': '/var/mail/cltbld', 07:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:51 INFO - 'MOZ_NO_REMOTE': '1', 07:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:51 INFO - 'NO_EM_RESTART': '1', 07:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:51 INFO - 'PWD': '/builds/slave/test', 07:54:51 INFO - 'SHELL': '/bin/bash', 07:54:51 INFO - 'SHLVL': '1', 07:54:51 INFO - 'TERM': 'linux', 07:54:51 INFO - 'TMOUT': '86400', 07:54:51 INFO - 'USER': 'cltbld', 07:54:51 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', 07:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:51 INFO - '_': '/tools/buildbot/bin/python'} 07:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:51 INFO - Downloading/unpacking psutil>=3.1.1 07:54:51 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 07:54:51 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 07:54:51 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 07:54:51 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 07:54:51 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 07:54:51 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 07:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:54:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:53 INFO - Installing collected packages: psutil 07:54:53 INFO - Running setup.py install for psutil 07:54:53 INFO - building 'psutil._psutil_linux' extension 07:54:53 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 07:54:54 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 07:54:54 INFO - building 'psutil._psutil_posix' extension 07:54:54 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 07:54:54 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 07:54:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:54 INFO - Successfully installed psutil 07:54:54 INFO - Cleaning up... 07:54:55 INFO - Return code: 0 07:54:55 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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', 'mozsystemmonitor==0.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1060267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d119c0>, '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 0x1d128c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d12d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', '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 07:54: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', 'mozsystemmonitor==0.1'] in /builds/slave/test/build 07:54: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 mozsystemmonitor==0.1 07:54:55 INFO - Using env: {'DISPLAY': ':0', 07:54:55 INFO - 'HOME': '/home/cltbld', 07:54:55 INFO - 'LANG': 'en_US.UTF-8', 07:54:55 INFO - 'LANGUAGE': 'en_US:en', 07:54:55 INFO - 'LOGNAME': 'cltbld', 07:54:55 INFO - 'MAIL': '/var/mail/cltbld', 07:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:55 INFO - 'MOZ_NO_REMOTE': '1', 07:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:55 INFO - 'NO_EM_RESTART': '1', 07:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:55 INFO - 'PWD': '/builds/slave/test', 07:54:55 INFO - 'SHELL': '/bin/bash', 07:54:55 INFO - 'SHLVL': '1', 07:54:55 INFO - 'TERM': 'linux', 07:54:55 INFO - 'TMOUT': '86400', 07:54:55 INFO - 'USER': 'cltbld', 07:54:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', 07:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:55 INFO - '_': '/tools/buildbot/bin/python'} 07:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:55 INFO - Downloading/unpacking mozsystemmonitor==0.1 07:54:55 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 07:54:55 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 07:54:55 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 07:54:55 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 07:54:55 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 07:54:55 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 07:54:57 INFO - Downloading mozsystemmonitor-0.1.tar.gz 07:54:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 07:54:57 INFO - Installing collected packages: mozsystemmonitor 07:54:57 INFO - Running setup.py install for mozsystemmonitor 07:54:57 INFO - Successfully installed mozsystemmonitor 07:54:57 INFO - Cleaning up... 07:54:57 INFO - Return code: 0 07:54:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:57 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 0x7f1060267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d119c0>, '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 0x1d128c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d12d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', '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 07:54:57 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 07:54:57 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 07:54:57 INFO - Using env: {'DISPLAY': ':0', 07:54:57 INFO - 'HOME': '/home/cltbld', 07:54:57 INFO - 'LANG': 'en_US.UTF-8', 07:54:57 INFO - 'LANGUAGE': 'en_US:en', 07:54:57 INFO - 'LOGNAME': 'cltbld', 07:54:57 INFO - 'MAIL': '/var/mail/cltbld', 07:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:57 INFO - 'MOZ_NO_REMOTE': '1', 07:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:57 INFO - 'NO_EM_RESTART': '1', 07:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:57 INFO - 'PWD': '/builds/slave/test', 07:54:57 INFO - 'SHELL': '/bin/bash', 07:54:57 INFO - 'SHLVL': '1', 07:54:57 INFO - 'TERM': 'linux', 07:54:57 INFO - 'TMOUT': '86400', 07:54:57 INFO - 'USER': 'cltbld', 07:54:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', 07:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:57 INFO - '_': '/tools/buildbot/bin/python'} 07:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:57 INFO - Downloading/unpacking blobuploader==1.2.4 07:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:59 INFO - Downloading blobuploader-1.2.4.tar.gz 07:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:54:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:54:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:00 INFO - Downloading docopt-0.6.1.tar.gz 07:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:55:00 INFO - Installing collected packages: blobuploader, requests, docopt 07:55:00 INFO - Running setup.py install for blobuploader 07:55:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:55:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:55:00 INFO - Running setup.py install for requests 07:55:00 INFO - Running setup.py install for docopt 07:55:00 INFO - Successfully installed blobuploader requests docopt 07:55:00 INFO - Cleaning up... 07:55:00 INFO - Return code: 0 07:55:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55: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')]} 07:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55: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')]} 07:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:00 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 0x7f1060267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d119c0>, '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 0x1d128c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d12d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', '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 07:55:00 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 07:55:00 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 07:55:00 INFO - Using env: {'DISPLAY': ':0', 07:55:00 INFO - 'HOME': '/home/cltbld', 07:55:00 INFO - 'LANG': 'en_US.UTF-8', 07:55:00 INFO - 'LANGUAGE': 'en_US:en', 07:55:00 INFO - 'LOGNAME': 'cltbld', 07:55:00 INFO - 'MAIL': '/var/mail/cltbld', 07:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:00 INFO - 'MOZ_NO_REMOTE': '1', 07:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:00 INFO - 'NO_EM_RESTART': '1', 07:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:00 INFO - 'PWD': '/builds/slave/test', 07:55:00 INFO - 'SHELL': '/bin/bash', 07:55:00 INFO - 'SHLVL': '1', 07:55:00 INFO - 'TERM': 'linux', 07:55:00 INFO - 'TMOUT': '86400', 07:55:00 INFO - 'USER': 'cltbld', 07:55:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', 07:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:00 INFO - '_': '/tools/buildbot/bin/python'} 07:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:55:00 INFO - Running setup.py (path:/tmp/pip-yDOs9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:55:01 INFO - Running setup.py (path:/tmp/pip-guGjFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:55:01 INFO - Running setup.py (path:/tmp/pip-hemQRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:55:01 INFO - Running setup.py (path:/tmp/pip-7H837_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:01 INFO - Running setup.py (path:/tmp/pip-0X3tcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:01 INFO - Running setup.py (path:/tmp/pip-AEqUe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:01 INFO - Running setup.py (path:/tmp/pip-dLsi30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:01 INFO - Running setup.py (path:/tmp/pip-vS_Aqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:01 INFO - Running setup.py (path:/tmp/pip-iVbMXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:01 INFO - Running setup.py (path:/tmp/pip-S8Z7e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:01 INFO - Running setup.py (path:/tmp/pip-NNFmlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:01 INFO - Running setup.py (path:/tmp/pip-uHHdbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:01 INFO - Running setup.py (path:/tmp/pip-GEg4Ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:01 INFO - Running setup.py (path:/tmp/pip-c1Sk0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:01 INFO - Running setup.py (path:/tmp/pip-gJG564-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:02 INFO - Running setup.py (path:/tmp/pip-cyMZ4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:02 INFO - Running setup.py (path:/tmp/pip-5tcOv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:55:02 INFO - Running setup.py install for manifestparser 07:55:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:55:02 INFO - Running setup.py install for mozcrash 07:55:02 INFO - Running setup.py install for mozdebug 07:55:02 INFO - Running setup.py install for mozdevice 07:55:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:55:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:55:02 INFO - Running setup.py install for mozfile 07:55:02 INFO - Running setup.py install for mozhttpd 07:55:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:55:02 INFO - Running setup.py install for mozinfo 07:55:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:55:02 INFO - Running setup.py install for mozInstall 07:55:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:55:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:55:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:55:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:55:02 INFO - Running setup.py install for mozleak 07:55:03 INFO - Running setup.py install for mozlog 07:55:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:55:03 INFO - Running setup.py install for moznetwork 07:55:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:55:03 INFO - Running setup.py install for mozprocess 07:55:03 INFO - Running setup.py install for mozprofile 07:55:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:55:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:55:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:55:03 INFO - Running setup.py install for mozrunner 07:55:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:55:03 INFO - Running setup.py install for mozscreenshot 07:55:03 INFO - Running setup.py install for moztest 07:55:03 INFO - Running setup.py install for mozversion 07:55:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:55:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:55:03 INFO - Cleaning up... 07:55:03 INFO - Return code: 0 07:55:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:03 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 0x7f1060267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d119c0>, '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 0x1d128c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d12d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', '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 07:55:03 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 07:55:03 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 07:55:03 INFO - Using env: {'DISPLAY': ':0', 07:55:03 INFO - 'HOME': '/home/cltbld', 07:55:03 INFO - 'LANG': 'en_US.UTF-8', 07:55:03 INFO - 'LANGUAGE': 'en_US:en', 07:55:03 INFO - 'LOGNAME': 'cltbld', 07:55:03 INFO - 'MAIL': '/var/mail/cltbld', 07:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:03 INFO - 'MOZ_NO_REMOTE': '1', 07:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:03 INFO - 'NO_EM_RESTART': '1', 07:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:03 INFO - 'PWD': '/builds/slave/test', 07:55:03 INFO - 'SHELL': '/bin/bash', 07:55:03 INFO - 'SHLVL': '1', 07:55:03 INFO - 'TERM': 'linux', 07:55:03 INFO - 'TMOUT': '86400', 07:55:03 INFO - 'USER': 'cltbld', 07:55:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', 07:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:03 INFO - '_': '/tools/buildbot/bin/python'} 07:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:55:04 INFO - Running setup.py (path:/tmp/pip-ZRF0Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:55:04 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)) 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:55:04 INFO - Running setup.py (path:/tmp/pip-fh_DZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:55:04 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)) 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:55:04 INFO - Running setup.py (path:/tmp/pip-kCfbp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:55:04 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)) 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:55:04 INFO - Running setup.py (path:/tmp/pip-VZDn9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:04 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)) 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:04 INFO - Running setup.py (path:/tmp/pip-2S83yV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:04 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)) 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:04 INFO - Running setup.py (path:/tmp/pip-ymhYbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:04 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)) 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:04 INFO - Running setup.py (path:/tmp/pip-SpayFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:04 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)) 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:04 INFO - Running setup.py (path:/tmp/pip-KbPmhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:04 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)) 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:04 INFO - Running setup.py (path:/tmp/pip-C73FA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:04 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)) 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:04 INFO - Running setup.py (path:/tmp/pip-GxR6PC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:04 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)) 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:04 INFO - Running setup.py (path:/tmp/pip-jb0x3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:04 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)) 07:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:04 INFO - Running setup.py (path:/tmp/pip-heVDnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:05 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)) 07:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:05 INFO - Running setup.py (path:/tmp/pip-hdrM74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:05 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)) 07:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:05 INFO - Running setup.py (path:/tmp/pip-MNi19S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:05 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)) 07:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:05 INFO - Running setup.py (path:/tmp/pip-tHlGJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:05 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)) 07:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:05 INFO - Running setup.py (path:/tmp/pip-_Bw4xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:05 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)) 07:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:05 INFO - Running setup.py (path:/tmp/pip-xIYVwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:05 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)) 07:55:05 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)) 07:55:05 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)) 07:55:05 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)) 07:55:05 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)) 07:55:05 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)) 07:55:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:55:05 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 07:55:05 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 07:55:05 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 07:55:05 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 07:55:05 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 07:55:05 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 07:55:07 INFO - Downloading blessings-1.6.tar.gz 07:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:55:07 INFO - Installing collected packages: blessings 07:55:07 INFO - Running setup.py install for blessings 07:55:07 INFO - Successfully installed blessings 07:55:07 INFO - Cleaning up... 07:55:07 INFO - Return code: 0 07:55:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:55:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:07 INFO - Reading from file tmpfile_stdout 07:55:07 INFO - Current package versions: 07:55:07 INFO - argparse == 1.2.1 07:55:07 INFO - blessings == 1.6 07:55:07 INFO - blobuploader == 1.2.4 07:55:07 INFO - docopt == 0.6.1 07:55:07 INFO - manifestparser == 1.1 07:55:07 INFO - mozInstall == 1.12 07:55:07 INFO - mozcrash == 0.17 07:55:07 INFO - mozdebug == 0.1 07:55:07 INFO - mozdevice == 0.48 07:55:07 INFO - mozfile == 1.2 07:55:07 INFO - mozhttpd == 0.7 07:55:07 INFO - mozinfo == 0.9 07:55:07 INFO - mozleak == 0.1 07:55:07 INFO - mozlog == 3.2 07:55:07 INFO - moznetwork == 0.27 07:55:07 INFO - mozprocess == 0.22 07:55:07 INFO - mozprofile == 0.28 07:55:07 INFO - mozrunner == 6.11 07:55:07 INFO - mozscreenshot == 0.1 07:55:07 INFO - mozsystemmonitor == 0.1 07:55:07 INFO - moztest == 0.7 07:55:07 INFO - mozversion == 1.4 07:55:07 INFO - psutil == 3.1.1 07:55:07 INFO - requests == 1.2.3 07:55:07 INFO - wsgiref == 0.1.2 07:55:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55: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')]} 07:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55: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')]} 07:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:07 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 0x7f1060267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d119c0>, '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 0x1d128c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d12d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', '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 07:55:07 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 07:55:07 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 07:55:07 INFO - Using env: {'DISPLAY': ':0', 07:55:07 INFO - 'HOME': '/home/cltbld', 07:55:07 INFO - 'LANG': 'en_US.UTF-8', 07:55:07 INFO - 'LANGUAGE': 'en_US:en', 07:55:07 INFO - 'LOGNAME': 'cltbld', 07:55:07 INFO - 'MAIL': '/var/mail/cltbld', 07:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:07 INFO - 'MOZ_NO_REMOTE': '1', 07:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:07 INFO - 'NO_EM_RESTART': '1', 07:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:07 INFO - 'PWD': '/builds/slave/test', 07:55:07 INFO - 'SHELL': '/bin/bash', 07:55:07 INFO - 'SHLVL': '1', 07:55:07 INFO - 'TERM': 'linux', 07:55:07 INFO - 'TMOUT': '86400', 07:55:07 INFO - 'USER': 'cltbld', 07:55:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', 07:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:07 INFO - '_': '/tools/buildbot/bin/python'} 07:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:07 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)) 07:55:07 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)) 07:55:07 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)) 07:55:07 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)) 07:55:07 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)) 07:55:07 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)) 07:55:07 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)) 07:55:07 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)) 07:55:07 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)) 07:55:07 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)) 07:55:07 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)) 07:55:07 INFO - Cleaning up... 07:55:07 INFO - Return code: 0 07:55:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:55: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')]} 07:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55: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')]} 07:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1060267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d119c0>, '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 0x1d128c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d12d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', '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 07:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:55:07 INFO - Using env: {'DISPLAY': ':0', 07:55:07 INFO - 'HOME': '/home/cltbld', 07:55:07 INFO - 'LANG': 'en_US.UTF-8', 07:55:07 INFO - 'LANGUAGE': 'en_US:en', 07:55:07 INFO - 'LOGNAME': 'cltbld', 07:55:07 INFO - 'MAIL': '/var/mail/cltbld', 07:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:07 INFO - 'MOZ_NO_REMOTE': '1', 07:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:07 INFO - 'NO_EM_RESTART': '1', 07:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:07 INFO - 'PWD': '/builds/slave/test', 07:55:07 INFO - 'SHELL': '/bin/bash', 07:55:07 INFO - 'SHLVL': '1', 07:55:07 INFO - 'TERM': 'linux', 07:55:07 INFO - 'TMOUT': '86400', 07:55:07 INFO - 'USER': 'cltbld', 07:55:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', 07:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:07 INFO - '_': '/tools/buildbot/bin/python'} 07:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:08 INFO - Downloading/unpacking jsonschema 07:55:08 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 07:55:08 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 07:55:08 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 07:55:08 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 07:55:08 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 07:55:08 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 07:55:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:55:10 INFO - Downloading/unpacking functools32 (from jsonschema) 07:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:10 INFO - Downloading functools32-3.2.3-2.tar.gz 07:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:55:10 INFO - warning: no files found matching '*.txt' 07:55:10 INFO - no previously-included directories found matching 'build' 07:55:10 INFO - no previously-included directories found matching 'dist' 07:55:10 INFO - no previously-included directories found matching '.git*' 07:55:10 INFO - Installing collected packages: jsonschema, functools32 07:55:10 INFO - Running setup.py install for functools32 07:55:10 INFO - warning: no files found matching '*.txt' 07:55:10 INFO - no previously-included directories found matching 'build' 07:55:10 INFO - no previously-included directories found matching 'dist' 07:55:10 INFO - no previously-included directories found matching '.git*' 07:55:10 INFO - Successfully installed jsonschema functools32 07:55:10 INFO - Cleaning up... 07:55:10 INFO - Return code: 0 07:55:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:10 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 0x7f1060267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d119c0>, '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 0x1d128c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d12d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', '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 07:55:10 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 07:55:10 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 07:55:10 INFO - Using env: {'DISPLAY': ':0', 07:55:10 INFO - 'HOME': '/home/cltbld', 07:55:10 INFO - 'LANG': 'en_US.UTF-8', 07:55:10 INFO - 'LANGUAGE': 'en_US:en', 07:55:10 INFO - 'LOGNAME': 'cltbld', 07:55:10 INFO - 'MAIL': '/var/mail/cltbld', 07:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:10 INFO - 'MOZ_NO_REMOTE': '1', 07:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:10 INFO - 'NO_EM_RESTART': '1', 07:55:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:10 INFO - 'PWD': '/builds/slave/test', 07:55:10 INFO - 'SHELL': '/bin/bash', 07:55:10 INFO - 'SHLVL': '1', 07:55:10 INFO - 'TERM': 'linux', 07:55:10 INFO - 'TMOUT': '86400', 07:55:10 INFO - 'USER': 'cltbld', 07:55:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', 07:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:10 INFO - '_': '/tools/buildbot/bin/python'} 07:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:10 INFO - Downloading/unpacking flake8 07:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:55:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:55:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:55:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:13 INFO - no previously-included directories found matching 'docs/_build' 07:55:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:55:13 INFO - Running setup.py install for pep8 07:55:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:13 INFO - no previously-included directories found matching 'docs/_build' 07:55:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:55:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:55:13 INFO - Cleaning up... 07:55:13 INFO - Return code: 0 07:55:13 INFO - Running post-action listener: _resource_record_post_action 07:55:13 INFO - Running post-action listener: _start_resource_monitoring 07:55:13 INFO - Starting resource monitoring. 07:55:13 INFO - ##### 07:55:13 INFO - ##### Finished create-virtualenv step (success) 07:55:13 INFO - ##### 07:55:13 INFO - ##### 07:55:13 INFO - ##### Running install step. 07:55:13 INFO - ##### 07:55:13 INFO - Running pre-action listener: _resource_record_pre_action 07:55:13 INFO - Running main action method: install 07:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:13 INFO - Reading from file tmpfile_stdout 07:55:13 INFO - Detecting whether we're running mozinstall >=1.0... 07:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:55:13 INFO - Reading from file tmpfile_stdout 07:55:13 INFO - Output received: 07:55:13 INFO - Usage: mozinstall [options] installer 07:55:13 INFO - Options: 07:55:13 INFO - -h, --help show this help message and exit 07:55:13 INFO - -d DEST, --destination=DEST 07:55:13 INFO - Directory to install application into. [default: 07:55:13 INFO - "/builds/slave/test"] 07:55:13 INFO - --app=APP Application being installed. [default: firefox] 07:55:13 INFO - mkdir: /builds/slave/test/build/application 07:55:13 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'] 07:55:13 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 07:55:29 INFO - Reading from file tmpfile_stdout 07:55:29 INFO - Output received: 07:55:29 INFO - /builds/slave/test/build/application/firefox/firefox 07:55:29 INFO - Running post-action listener: _resource_record_post_action 07:55:29 INFO - ##### 07:55:29 INFO - ##### Finished install step (success) 07:55:29 INFO - ##### 07:55:29 INFO - ##### 07:55:29 INFO - ##### Running run-tests step. 07:55:29 INFO - ##### 07:55:29 INFO - Running pre-action listener: _resource_record_pre_action 07:55:29 INFO - Running main action method: run_tests 07:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:55:29 INFO - Python 2.7.3 07:55:29 INFO - Return code: 0 07:55:29 INFO - grabbing minidump binary from tooltool 07:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:29 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 0x1d119c0>, '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 0x1d128c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d12d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:55:29 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 07:55:29 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 07:55:29 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 07:55:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:55:29 INFO - Return code: 0 07:55:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:55:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:55:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:55:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:55:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:55:30 INFO - Return code: 0 07:55:30 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/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 07:55:30 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/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 07:55:30 INFO - Using env: {'DISPLAY': ':0', 07:55:30 INFO - 'HOME': '/home/cltbld', 07:55:30 INFO - 'LANG': 'en_US.UTF-8', 07:55:30 INFO - 'LANGUAGE': 'en_US:en', 07:55:30 INFO - 'LOGNAME': 'cltbld', 07:55:30 INFO - 'MAIL': '/var/mail/cltbld', 07:55:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:55:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:30 INFO - 'MOZ_NO_REMOTE': '1', 07:55:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:30 INFO - 'NO_EM_RESTART': '1', 07:55:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:30 INFO - 'PWD': '/builds/slave/test', 07:55:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:55:30 INFO - 'SHELL': '/bin/bash', 07:55:30 INFO - 'SHLVL': '1', 07:55:30 INFO - 'TERM': 'linux', 07:55:30 INFO - 'TMOUT': '86400', 07:55:30 INFO - 'USER': 'cltbld', 07:55:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503', 07:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:30 INFO - '_': '/tools/buildbot/bin/python'} 07:55:30 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/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 07:55:30 INFO - mozversion application_buildid: 20160513071835 07:55:30 INFO - mozversion application_changeset: cc0133021748b050a03cb242dfa4af51a3a46112 07:55:30 INFO - mozversion application_display_name: Nightly 07:55:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:55:30 INFO - mozversion application_name: Firefox 07:55:30 INFO - mozversion application_remotingname: firefox 07:55:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:55:30 INFO - mozversion application_vendor: Mozilla 07:55:30 INFO - mozversion application_version: 49.0a1 07:55:30 INFO - mozversion platform_buildid: 20160513071835 07:55:30 INFO - mozversion platform_changeset: cc0133021748b050a03cb242dfa4af51a3a46112 07:55:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:55:30 INFO - mozversion platform_version: 49.0a1 07:55:30 INFO - using testdate: 1463151330 07:55:30 INFO - actual date: 1463151330 07:55:30 INFO - starting webserver on 'localhost:34773' 07:55:30 INFO - SUITE-START | Running 2 tests 07:55:30 INFO - TEST-START | dromaeo_css 07:55:30 INFO - operating with platform_type : linux_ 07:55:30 INFO - Initialising browser for dromaeo_css test... 07:55:30 INFO - TEST-INFO | started process 4518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjaROvo/profile http://localhost:34773/getInfo.html) 07:55:34 INFO - PROCESS | 4518 | __metrics Screen width/height:1600/1200 07:55:34 INFO - PROCESS | 4518 | colorDepth:24 07:55:34 INFO - PROCESS | 4518 | Browser inner width/height: 1024/697 07:55:34 INFO - PROCESS | 4518 | __metrics 07:55:35 ERROR - PROCESS | 4518 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:55:36 INFO - TEST-INFO | 4518: exit 0 07:55:36 INFO - Browser initialized. 07:55:36 INFO - Running cycle 1/1 for dromaeo_css test... 07:55:36 INFO - TEST-INFO | started process 4600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjaROvo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:48 INFO - PROCESS | 4600 | RSS: Main: 154398720 07:55:48 INFO - PROCESS | 4600 | 07:56:40 INFO - PROCESS | 4600 | 1463151400041 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] 07:58:51 INFO - PROCESS | 4600 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34773/tests/dromaeo/cssquery-ext.html) 07:58:52 INFO - PROCESS | 4600 | RSS: Main: 232947712 07:58:52 INFO - PROCESS | 4600 | 08:01:55 INFO - PROCESS | 4600 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-ext.html (next: http://localhost:34773/tests/dromaeo/cssquery-jquery.html) 08:01:55 INFO - PROCESS | 4600 | RSS: Main: 238112768 08:01:55 INFO - PROCESS | 4600 | 08:04:58 INFO - PROCESS | 4600 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34773/tests/dromaeo/cssquery-mootools.html) 08:04:58 INFO - PROCESS | 4600 | RSS: Main: 234688512 08:04:58 INFO - PROCESS | 4600 | 08:08:00 INFO - PROCESS | 4600 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34773/tests/dromaeo/cssquery-prototype.html) 08:08:01 INFO - PROCESS | 4600 | RSS: Main: 229576704 08:08:01 INFO - PROCESS | 4600 | 08:11:04 INFO - PROCESS | 4600 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34773/tests/dromaeo/cssquery-yui.html) 08:11:04 INFO - PROCESS | 4600 | RSS: Main: 213282816 08:11:04 INFO - PROCESS | 4600 | 08:14:07 INFO - PROCESS | 4600 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-yui.html (next: http://localhost:34773/tests/dromaeo/cssquery-dojo.html) 08:14:08 INFO - PROCESS | 4600 | RSS: Main: 247287808 08:14:08 INFO - PROCESS | 4600 | 08:14:08 INFO - PROCESS | 4600 | __start_tp_report 08:14:08 INFO - PROCESS | 4600 | _x_x_mozilla_page_load 08:14:08 INFO - PROCESS | 4600 | _x_x_mozilla_page_load_details 08:14:08 INFO - PROCESS | 4600 | |i|pagename|runs| 08:14:08 INFO - PROCESS | 4600 | |0;dojo.html;2666.6000099985;2671.9866400667993;2704.215777424547;2707.269037359912;2714.7285271472856;4670.206064968955;4718.433787945447;4753.572178503934;4796.328514008037;4843.685160464572;4749.8812529686775;4789.497102804207;4805.423349198092;4813.3983252093485;4848.393950756155;4357.498887627924;4363.170997510479;4422.336649502568;4473.776311184444;4553.248713962193;4459.620932220765;4501.504834468222;4522.163399771036;4522.29904364824;4551.203539380595;4315.956840431587;4334.631556317717;4350.042990542076;4359.738415695068;4403.097365040175;4403.515613282536;4404.207242696313;4407.691461597689;4411.42651455312;4451.532589078132;4410.514843367227;4418.1384629997165;4420.270655341865;4468.977655111737;4474.552544745532;4596.448426188846;4673.813047478096;4739.12326219647;4751.501092385284;4798.136335459616;5191.428942816287;5213.635045546814;5254.133068043769;5255.921161182585;5259.658122222043;5233.293505376763;5260.526552610283;5279.947200527984;5287.074761916688;5288.180332048539;4632.25883858581;4712.387389639325;4792.849716068154;4828.203346447796;4830.203016502308;5311.176767601028;5336.893262134736;5341.545968592635;5342.332208473941;5357.732113394315;5058.595312375001;5083.949160508421;5113.923291150636;5126.1798112302595;5128.897422051613;5031.647784655039;5093.23601459784;5135.897282054338;5142.897142057138;5169.457206993212;5092.592592592584;5125.282460455539;5133.178691409356;5138.100832354323;5185.922211166836;4979.103761322996;5104.668196567211;5110.105731496973;5112.105381558213;5113.565346945476;4218.7679677618025;4276.850310239127;4279.679024073207;4287.2711639021445;4287.849925252601;3757.774533527997;3767.3218820612005;3767.585565587783;3777.0557360659836;3808.7143464240294;4341.717788343748;4381.452318460192;4448.955510444919;4457.866264012085;4490.685652004394;5120.948790512121;5130.563902068291;5132.56373208274;5197.194434862527;5198.662086964335;4436.556344365602;4467.218236808546;4468.4414448193975;4468.910621787546;4518.593326600621;4510.255807791677;4554.476235232991;4626.467956185014;4632.305154226893;4672.859814205579;4842.854714358646;4861.927071094007;4864.537868902448;4885.316055752127;4926.458089610212;5125.308083408692;5134.28120063184;5146.330976972969;5161.174212126042;5196.584273258055;4642.791074401593;4768.117898188846;4815.855524334275;4877.512248775236;4937.580305674058;4990.575801056951;5016.523430274118;5016.673916195436;5022.221555658879;5044.445111037856;5065.822696205615;5074.847754567369;5075.1625981712605;5081.898362032664;5115.897682046264;4830.468648448597;4916.311716359784;4946.579540738933;4993.80024799004;4996.2755400466;4976.253561965734;4997.150484417585;5002.099622068063;5004.074246264453;5054.19132938728;4929.211326187936;4940.283658869372;4946.752662366939;4988.226824842155;4988.501149884983;4896.583790377716;4988.700677959334;5026.673266237683;5054.140796064751;5086.694798312114;4940.802367905244;4959.975200123977;4963.528464795839;4968.726720030433;5014.022265658162 08:14:08 INFO - PROCESS | 4600 | |1;ext.html;559.9020171469991;584.9151872978418;591.801746414951;602.9547783916207;614.8739508400777;41671.79164104179;42948.57051429485;43008.354874676865;43153;46566.76716616412;42933.57066429335;43203.35194972078;43333.566664333346;43415.78292108543;43423;8017.639206235719;8148.22591853773;8150.877736833952;8151.918480815205;8155.632996515142;7959.204079592024;8037.437379383446;8048.074471435772;8053.516788992679;8059.314958228558;8021.157778433268;8087.3934454915825;8121.30968867647;8125.59372031399;8125.959370203141;7916.445848790587;8034.638441270127;8045.356371490267;8066.838663226703;8067.394945379061;7917.168697286759;7997.560134192617;7997.720079797179;7999.440039197259;8001.239882211181;39468.407973880414;39786.403203951966;39793.60206397928;39819.20361592781;39836.20327593432;3232.595925509311;3257.641659417462;3442.6041005284465;3721.7394782365245;3805.2769973705185;29239.2690182745;29770.255743606365;30089;30390.54414183789;30903.845480772452;2988.5965394671657;3058.6023816903885;3090.7681923855575;3103;3140.905772826819;276331;278362;278723.99999999796;278902;280474;52913.47086529085;53212.73393633084;53276.46723532715;53365;53408;51103.23345149826;57230;57918.4208157913;59420.7028964861;59481;15596.532104036896;15768.526944191693;15824.525264242091;15837.604059898364;15841.287142078634;12137;12243.755124897452;12245;12251.93874030642;12254.509819607294;14256.073355231876;15748.291326890318;15803.13082780435;16042.75935860963;16249.106299153424;5999.610025348338;6115.951156362579;6146.385361463817;6192.102145188923;6228.532860035515;933;949.7103383468109;991.6529214774771;998.3163315836416;1074.9841399877198;27988.739877288175;28677;28687;29106.27234319159;29157.27106822304;1037.2790910317408;1064.9361038337724;1068.9465526723632;1084.4415126210008;1087.907527860125;15123.470678526199;15453.5363939082;15465;15552.377904883679;15557;338411;338534;339297;342291;342414;49581.752091240036;50503.24245136326;50593.24110138351;50692.746536267085;50820.49179508157;1180.9586664466703;1211.54567037361;1214.732758793064;1284.8393950756156;1315.5333749220213;24357.51284974255;30220.84889575626;30477.54283685791;32658.183545411553;33212.33575328528;48422.273665895744;49166.508334916194;49202;49277.75361123172;49359.259611105146;344567;348045;348179;349379;349892;33001.50497742584;35670.68750906006;37023.88928332154;37462;37643.811780942015;39318.803405982784;43183.568164317956;43444.78277608718;43613.78193109141;43692.34461483144;37162.442563362114;37259.44110838285;37300.81349593234;37551;37698.81150594229;36100.81949590235;36173;36289.63710362863;36699.63300366962;36801.447978279815;35650;35768.28463430665;36016.63983360238;36017;37200.25599487941;29829.403411931205;32090.19774505656;32749.181270468427;32880.50679239765;32981;24896.751032489443;24982.875085624455;25017.499650007263;25199.11803086883;25464.74535254698 08:14:08 INFO - PROCESS | 4600 | |2;jquery.html;361.7829302418549;365.8244042859427;374.11521751058757;381.1367253171565;381.3935842011202;16327.183640817957;17202.39791607294;17282;17500.124993750323;17617.91191044043;16400.179991000463;16703.582410439743;17844.197011134496;17851.375201867937;17853.821461785377;4579.450465944083;4755.120302743986;4795.2087905495555;4803.5676789088975;4808.783604737778;3395.2190996070917;4710.599599034069;5030.396352437712;5290.470952904717;5299.258103865462;5307.65500242483;5336.733163341837;5350.625456218067;5357.973210133944;5361.08861493547;5134.460881607433;5197.454267301936;5249.317588713462;5252.501012403815;5260.316158899319;3182.809031458097;4984.526469985346;5047.47001564834;5280.709560974145;5288.418273989858;11289.661310160709;11308.208425410225;11417.200795944287;11433.14251431146;11950;1879.8590105741987;1884.1615481110912;1911.4934542346289;1925.4993701637536;2056.393363957636;9145.679901203492;9287.210587100104;9485.383450075791;9490.145886870147;9636.421814691072;1581.7311057120203;1697.5671203843065;1721.6040310728476;1757.4551888914477;1845.9446216613524;63445.68277158631;67081.329186708;68499;76474;76814.23185768182;9530.904690953003;9571.856422153673;9681.757956051155;9797.363171393836;9873.308868379145;12773.872261277455;13021.674458138623;13093.279869607262;13132;13194.604161875159;6792.422644075309;6878.174619045746;6882.311768823178;6961.060256865258;7005.124359455068;6487.805365839033;6579.75800290787;6650.634215118215;6651.068850360954;6655.866882662416;3998.960010399917;4113.177364527107;4269.87190384289;4274.508431530352;4276.401303817468;1612.1939030484757;1632.4368093007893;1746.6419384026499;1828.743975843383;1877.7840548337117;862.5945805471418;915.6428992692855;962.2686758063921;962.6919385796477;986.7631768375538;16806.243719032675;17197.914010429868;17277.913610431868;17386.565335866704;17573.560660983578;939.0656296984544;944.8724422203052;957.7461972577272;957.861110139026;962.7496850818837;9370.906290937004;9846.163076138466;9854.704358869245;9860.359076659994;9911.207103431709;363346;364205;364343;373673;376074;80612.59693701494;80700.59649701713;80822.59588702019;81184;82205.58897205476;903.290916630442;906.5376657904516;923.4690053219291;928.8560273157672;930.251147825993;15187.468438604596;15200.391984320504;15371.692566148839;15427.691446171239;15543.300551474984;36623.26753464969;37127;37437.251254975294;37517.06207344838;37590;44727;46645.30032049454;48601.513984859695;49072.50927490679;51789.223161651855;6757.391834734897;7039.120109986252;7179.246179151114;7608.16310205888;7739.993800806084;11512.827307590225;11715.472803723682;11947.283163010246;12140.817887731868;12287.262764234174;10575.471226438493;10642.467876606293;10681.786364272826;10763.3541987481;10866.96763807437;5251.159814429673;8370.53962032094;10228.897711023092;10266.716660417447;10363.119134873621;10597.4701264938;10602.469876506299;10860.891391085988;10890.346579205274;11000.724981875517;6594.439472644687;6979.651017449209;7124.536905101152;7238.963805180941;7300.926990730025;9014.684486042957;10349.275550711378;10466.215033872642;10561.10230630405;10765.784684306112 08:14:08 INFO - PROCESS | 4600 | |3;mootools.html;1300.4018151650241;1521.383839544984;1534.8004759381279;1697.9915100424503;1883.8681292309536;7569.129550101733;7908.565028923407;7938.047434307877;8127.5529845858455;8131.186881311866;7891.684332626703;8069.959650201756;8074.3136833369235;8075.829004794301;8078.9192108078905;2244.0350649220827;2268.25147701259;2269.069681430614;2270.114655284432;2272.1138755885136;2260.9321720348416;2297.8965946532444;2312.537492501498;2317.536492701458;2317.8377513574055;2227.40973641985;2238.3956331790405;2262.151693115082;2262.298687406901;2264.286749673856;2125.0224896547606;2148.6132496150685;2161.438026113206;2167.53398019425;2168.425367277665;2098.4648914526697;2114.302280247515;2122.206735308662;2122.777108403611;2123.819475344598;7771.184025677279;7824.061112666516;7904.446688731791;7919.247671471201;8175.5503447310375;4672.182368085571;4712.293156026589;4712.505186955389;4716.127516409475;4721.433427988629;2941.5440606705993;2950.4099180164053;2993.3863557970562;3014.4724673182104;3044.8325342106177;907.5779762410444;923.3536524432857;923.9630414783401;932.2868005975434;938.7606160429115;10885.564577416893;10907.509162087725;10919.727006824813;10977.83533247002;10981.945090274497;4014.1369605534364;4141.275276826544;4162.937555936664;4204.1801848639225;4208.368744688321;8625.180607842245;8677.045524992245;8749.212570868653;8761.912380876238;8765.430247033923;4693.507181745936;4693.95306046942;4697.060587882437;4699.882502937454;4702.976485117552;3697.4268988306853;4189.099343641071;4328.3723860040745;4402.515723270438;4415.933760993587;3410.3349846780134;3455.2571197192224;3458.2564748578675;3462.8614855406004;3551.3074950384944;1042.0465274274106;1053.9262251642465;1059.4384975962753;1080.5137688040256;1081.6376513867785;722.8590424867206;824.5629816197425;844.5861527851308;859.58739804894;940.6284517615503;5261.605379596545;5318.361796584435;5338.519533242027;5444.8094316698725;5521.4478552144465;934.817710546437;960.8259522471541;975.0639386189196;976.9658061967939;987.9950600247097;3795.658390744846;3823.6941044716355;3893.552241492208;3973.264945985002;4004.3192657248337;9798.363106398061;10082.495875206358;10161.847572286422;10169;10194.643187488402;9812.90187098134;9989.051040151175;10106.191504679608;10180.592776288866;10180.694579162637;7446.888296675555;7482.176960534337;7579.62101894903;7586.62066896664;7611.086669599573;5238.397584277857;5260.500252476008;5386.8383948481605;5410.918836217538;5458.263134476795;8841.115888411108;9117.544122793966;9145.451272923647;9207.17135457812;9212.216961558343;8916.465012099035;9200.033996430546;9628.133467987915;9639.277054220822;9650.08324209199;6996.860062798817;7162.498625096193;7173.784786456415;7185.17370502378;7220.530665506725;7646.350060244941;7755.573443460664;7799.688012479437;7801.258880406353;7801.765947021599;6820.04519367279;7059.964700176466;7089.042979197742;7198.136223653195;7255.4921155518605;6849.520533562602;6885.070515480546;6925.20360158568;6981.5461994970165;7190.568565886064;6343.3339499351905;6428.228612566522;6452.709628066655;6454.806355809334;6461;4753.9762301188275;4771.093492236603;4818.084563932842;4917.237828136645;4950.6782059166035;4993.17612593918;5091.490850914879;5126.307948426915;5179.482051794941;5221.138512145605 08:14:08 INFO - PROCESS | 4600 | |4;prototype.html;274.3525280338401;279.8195164119142;281.9873105710244;304.6739988212612;309.94421004219237;4771.35586695796;4800.735959522225;4818.638602104838;4821.156297647911;4841.273808928662;4734.147853386397;4775.808967641299;4801.84755658642;4822.890735130922;4836.854894353166;3597.4603809428663;3709.684676802475;3738.663520283174;3780.8676696315633;3835.3479908415497;3768.8492460301554;3798.2973149967343;3804.068003339186;3816.809159542012;3819.140693344003;3592.5868525119686;3761.13493896404;3772.9811350943205;3782.583915769263;3796.4305354196817;3700.4079347304437;3783.8297276622343;3785.867494637702;3793.146542028049;3813.3326667833294;3359.5296658467832;3360.83195840207;3371.325734853039;3375.71306438953;3379.172102834821;4564.5435456454425;4590.770461476946;4598.287265473857;4606.470255920579;4618.2610782275015;4219.198352313051;4347.130573885235;4358.8038538265855;4368.213721530124;4369.912601747979;5027.899442011176;5035.640377098163;5060.544550990392;5077.949220507785;5078.5937125029905;3669.6513831185994;3691.6492933171307;3694.5197124373926;3704.5369328833895;3707.3326801175776;4982.377202849644;5258.868528286824;5269.394019687747;5274.314339135926;5290.814821481268;3651.3062518121474;3657.5062366580173;3680.9447858282147;3682.502862113634;3682.9815850920572;3717.1636381813873;3721.4603882436895;3727.235916637083;3729.284529116637;3734.2344819311975;4217.957820421757;4226.936595951063;4289.1850548395705;4292.613664770123;4293.549177336335;4771.785269662873;5006.4743201964;5015.448300686921;5044.873878153002;5047.924281135786;1276.6233960981533;1276.6489215465822;1286.9163504372186;1290.167841742071;1292.3667402972665;825.6078362777632;837.2172019162103;871.7428358634218;889.782003409156;895.4627223665749;4466.553344665507;4475.395821564112;4475.843345482893;4491.214037543416;4504.648605418427;5123.948760512347;5126.256692779601;5149.094834911032;5177.534021938043;5207.3751149862255;4308.439902812677;4377.212101821703;4422.977885110554;4460.1525710114975;4490.191765482179;2728.7271272872554;2755.3800394910986;2765.502209602251;2769.739768405371;2782.2348854065294;4774.832880849153;4821.54195351441;4879.608991594164;4907.975460122677;4932.161532539477;5107.293134638648;5224.52979231871;5251.921221181686;5272.894542109137;5279.947200528022;4846.733429661403;4870.756462176806;4885.438174609894;4889.144399730033;4892.8532144035735;5124.12889808726;5168.9741551292;5172.844814655567;5195.6622819516615;5205.193195054772;4880.536349046835;5048.974755126201;5066.113430149783;5144.993452553433;5165.225216217597;4983.601311895112;4984.352034235526;4985.9501404985485;4989;4999.950000499948;3698.389765688631;3736.215394767021;3743.3262012836863;3746.981265093657;3747.6065013174316;5043.722595257149;5129.204973229155;5223.503767142115;5322.095243808484;5326.721586819213;5041.6470847040355;5059.595232381327;5101.540861322499;5110.284560161655;5125.846224613268;5103.8468845934685;5123.795048198031;5151.974240128925;5173.689578625294;5173.948260517347;4687.460941991714;4761.309610106585;5000.599952003904;5087.771050302671;5096.108181068373;5029.4216165140015;5097.92353114711;5121.7695203715175;5130.307408499804;5130.897382052263;4959.380077490314;4991.0784348025545;4993.400791904995;5010.599152067753;5018.899622007612 08:14:08 INFO - PROCESS | 4600 | |5;yui.html;751.0311697909693;754.9584772837493;772.3820943245403;779.695918591749;804.3565147881695;11830.112741544375;11906.34515101669;11965.461554230058;11982.7603447931;12021.15851890368;12165.817512737316;12433.875661243384;12452.564160254393;12460.190087644296;12481.563145289916;685.6263336481604;841.4488510025943;848.3298194426395;877.7586163804941;878.056089703568;868.7176667583029;879.7360791762478;879.7976465412959;880.1154839386408;880.6565439478609;920.2821798996794;925.1165137293901;925.9259259259243;926.2173463423396;926.3191554207652;713.8929160625947;891.1088911088912;911.1207684584408;913.9817203655923;914.6615752171706;676.0940339944498;676.4047638078508;676.47573130824;676.5534747066962;676.719161547957;12162.817557736642;12190.939045304716;12196.329201893892;12210.511579536807;12222.144449888512;11755.58855440064;12043.191837138984;12072.336021518813;12093.395330233454;12127.454264558117;10660.413677247749;10751.193660475417;10853.34879907208;10976.286541374864;11036.448177591168;3964.6630036446936;4026.7382620129597;4063.97968010161;4071.470708807836;4196.748195108304;45464.318035229495;45473.772631136635;45570;47358;47826.28260576059;9352.345335826563;9382.155605995493;9633.277504187214;9670.854937175947;9732.221422286342;16847.578810529834;17202.913985429994;17371.218295176746;17392.47822565325;17395.217215225344;6343.873122537523;6382.648954307558;6383.042543618494;6446.323136070739;6565.540412171198;3669.633036696309;3694.4827724118645;3725.403935370328;3736.626337366242;3767.547894252707;2786.721327867197;2885.1488810800865;2897.652281726206;2897.884084636633;2899.695531969113;545.2312239741944;568.6048196503473;571.9199312096309;579.8579348059752;581.9127130930394;480.5362824873944;578.2511647416605;580.7705956147382;588.8645611509377;617.9907301390393;7806.570638614817;8268.131846156188;8299.917000829915;8443.282321002784;8465.068842427328;473.7015680121501;550.931133608299;562.0753859900523;571.5341996273024;572.2104739395447;3599.1002249437643;3600.279944011208;3617.819109044537;3631.6368363163474;3797.905052373713;50960;51205.48794512082;51311;51446.485535144915;55908;49359;50470.49529504658;50802.91970802964;51143.23285150726;51192.23211651828;45991.31013034807;46231.53768462272;46292.768536157775;46325;47016.5298347019;6862.828429289308;7066.823329416806;7096.645167741695;7157.856842863218;7430.851382972419;29741.85129074341;29915.850420747756;30423.695763042087;30544.236394090327;30715.2321191972;36672.44991325079;39429;40377.1924561513;40476.79761601291;41274.79362603288;9817.992203213242;10012.44931528773;10070.295079344376;10123.696289111338;10170.79658406813;11050.889491104987;11265.155113366694;11377.886221137682;11398.829017564909;11450.427478625868;9947;10266.743331416774;10431.269811113452;10481.056704896597;10503.47482625881;9301.069893010645;9635.5663995119;9644.373115747454;9700.126988571063;9735.659251926148;9211.539423028957;9562.139407453084;9655.565499552396;9667;9674.9032509674;8472.691181677961;8556.058833528183;8580.442271252348;8637.956810215908;8825.338099642424;8474.872876906975;8740.388172828096;8962.820743585222;10120.696379108638;10166.475287193376 08:14:08 INFO - PROCESS | 4600 | __end_tp_report 08:14:08 INFO - PROCESS | 4600 | __start_cc_report 08:14:08 INFO - PROCESS | 4600 | _x_x_mozilla_cycle_collect,1110 08:14:08 INFO - PROCESS | 4600 | __end_cc_report 08:14:08 INFO - PROCESS | 4600 | __startTimestamp1463152448101__endTimestamp 08:14:08 INFO - PROCESS | 4600 | 08:14:08 INFO - PROCESS | 4600 | ------- Summary: start ------- 08:14:08 INFO - PROCESS | 4600 | Number of tests: 6 08:14:08 INFO - PROCESS | 4600 | 08:14:08 INFO - PROCESS | 4600 | [#0] dojo.html Cycles:165 Average:4747.57 Median:4877.51 stddev:505.01 (10.4%) stddev-sans-first:479.45 08:14:08 INFO - PROCESS | 4600 | Values: 2666.6 2672.0 2704.2 2707.3 2714.7 4670.2 4718.4 4753.6 4796.3 4843.7 4749.9 4789.5 4805.4 4813.4 4848.4 4357.5 4363.2 4422.3 4473.8 4553.2 4459.6 4501.5 4522.2 4522.3 4551.2 4316.0 4334.6 4350.0 4359.7 4403.1 4403.5 4404.2 4407.7 4411.4 4451.5 4410.5 4418.1 4420.3 4469.0 4474.6 4596.4 4673.8 4739.1 4751.5 4798.1 5191.4 5213.6 5254.1 5255.9 5259.7 5233.3 5260.5 5279.9 5287.1 5288.2 4632.3 4712.4 4792.8 4828.2 4830.2 5311.2 5336.9 5341.5 5342.3 5357.7 5058.6 5083.9 5113.9 5126.2 5128.9 5031.6 5093.2 5135.9 5142.9 5169.5 5092.6 5125.3 5133.2 5138.1 5185.9 4979.1 5104.7 5110.1 5112.1 5113.6 4218.8 4276.9 4279.7 4287.3 4287.8 3757.8 3767.3 3767.6 3777.1 3808.7 4341.7 4381.5 4449.0 4457.9 4490.7 5120.9 5130.6 5132.6 5197.2 5198.7 4436.6 4467.2 4468.4 4468.9 4518.6 4510.3 4554.5 4626.5 4632.3 4672.9 4842.9 4861.9 4864.5 4885.3 4926.5 5125.3 5134.3 5146.3 5161.2 5196.6 4642.8 4768.1 4815.9 4877.5 4937.6 4990.6 5016.5 5016.7 5022.2 5044.4 5065.8 5074.8 5075.2 5081.9 5115.9 4830.5 4916.3 4946.6 4993.8 4996.3 4976.3 4997.2 5002.1 5004.1 5054.2 4929.2 4940.3 4946.8 4988.2 4988.5 4896.6 4988.7 5026.7 5054.1 5086.7 4940.8 4960.0 4963.5 4968.7 5014.0 08:14:08 INFO - PROCESS | 4600 | 08:14:08 INFO - PROCESS | 4600 | [#1] ext.html Cycles:180 Average:48719.00 Median:37093.17 stddev:84914.60 (228.9%) stddev-sans-first:85075.82 08:14:08 INFO - PROCESS | 4600 | Values: 559.9 584.9 591.8 603.0 614.9 41671.8 42948.6 43008.4 43153.0 46566.8 42933.6 43203.4 43333.6 43415.8 43423.0 8017.6 8148.2 8150.9 8151.9 8155.6 7959.2 8037.4 8048.1 8053.5 8059.3 8021.2 8087.4 8121.3 8125.6 8126.0 7916.4 8034.6 8045.4 8066.8 8067.4 7917.2 7997.6 7997.7 7999.4 8001.2 39468.4 39786.4 39793.6 39819.2 39836.2 3232.6 3257.6 3442.6 3721.7 3805.3 29239.3 29770.3 30089.0 30390.5 30903.8 2988.6 3058.6 3090.8 3103.0 3140.9 276331.0 278362.0 278724.0 278902.0 280474.0 52913.5 53212.7 53276.5 53365.0 53408.0 51103.2 57230.0 57918.4 59420.7 59481.0 15596.5 15768.5 15824.5 15837.6 15841.3 12137.0 12243.8 12245.0 12251.9 12254.5 14256.1 15748.3 15803.1 16042.8 16249.1 5999.6 6116.0 6146.4 6192.1 6228.5 933.0 949.7 991.7 998.3 1075.0 27988.7 28677.0 28687.0 29106.3 29157.3 1037.3 1064.9 1068.9 1084.4 1087.9 15123.5 15453.5 15465.0 15552.4 15557.0 338411.0 338534.0 339297.0 342291.0 342414.0 49581.8 50503.2 50593.2 50692.7 50820.5 1181.0 1211.5 1214.7 1284.8 1315.5 24357.5 30220.8 30477.5 32658.2 33212.3 48422.3 49166.5 49202.0 49277.8 49359.3 344567.0 348045.0 348179.0 349379.0 349892.0 33001.5 35670.7 37023.9 37462.0 37643.8 39318.8 43183.6 43444.8 43613.8 43692.3 37162.4 37259.4 37300.8 37551.0 37698.8 36100.8 36173.0 36289.6 36699.6 36801.4 35650.0 35768.3 36016.6 36017.0 37200.3 29829.4 32090.2 32749.2 32880.5 32981.0 24896.8 24982.9 25017.5 25199.1 25464.7 08:14:08 INFO - PROCESS | 4600 | 08:14:08 INFO - PROCESS | 4600 | [#2] jquery.html Cycles:180 Average:23437.86 Median:25612.38 stddev:61139.99 (238.7%) stddev-sans-first:61286.95 08:14:08 INFO - PROCESS | 4600 | Values: 361.8 365.8 374.1 381.1 381.4 16327.2 17202.4 17282.0 17500.1 17617.9 16400.2 16703.6 17844.2 17851.4 17853.8 4579.5 4755.1 4795.2 4803.6 4808.8 3395.2 4710.6 5030.4 5290.5 5299.3 5307.7 5336.7 5350.6 5358.0 5361.1 5134.5 5197.5 5249.3 5252.5 5260.3 3182.8 4984.5 5047.5 5280.7 5288.4 11289.7 11308.2 11417.2 11433.1 11950.0 1879.9 1884.2 1911.5 1925.5 2056.4 9145.7 9287.2 9485.4 9490.1 9636.4 1581.7 1697.6 1721.6 1757.5 1845.9 63445.7 67081.3 68499.0 76474.0 76814.2 9530.9 9571.9 9681.8 9797.4 9873.3 12773.9 13021.7 13093.3 13132.0 13194.6 6792.4 6878.2 6882.3 6961.1 7005.1 6487.8 6579.8 6650.6 6651.1 6655.9 3999.0 4113.2 4269.9 4274.5 4276.4 1612.2 1632.4 1746.6 1828.7 1877.8 862.6 915.6 962.3 962.7 986.8 16806.2 17197.9 17277.9 17386.6 17573.6 939.1 944.9 957.7 957.9 962.7 9370.9 9846.2 9854.7 9860.4 9911.2 363346.0 364205.0 364343.0 373673.0 376074.0 80612.6 80700.6 80822.6 81184.0 82205.6 903.3 906.5 923.5 928.9 930.3 15187.5 15200.4 15371.7 15427.7 15543.3 36623.3 37127.0 37437.3 37517.1 37590.0 44727.0 46645.3 48601.5 49072.5 51789.2 6757.4 7039.1 7179.2 7608.2 7740.0 11512.8 11715.5 11947.3 12140.8 12287.3 10575.5 10642.5 10681.8 10763.4 10867.0 5251.2 8370.5 10228.9 10266.7 10363.1 10597.5 10602.5 10860.9 10890.3 11000.7 6594.4 6979.7 7124.5 7239.0 7300.9 9014.7 10349.3 10466.2 10561.1 10765.8 08:14:08 INFO - PROCESS | 4600 | 08:14:08 INFO - PROCESS | 4600 | [#3] mootools.html Cycles:180 Average:5288.65 Median:5200.31 stddev:2965.85 (57.0%) stddev-sans-first:2959.03 08:14:08 INFO - PROCESS | 4600 | Values: 1300.4 1521.4 1534.8 1698.0 1883.9 7569.1 7908.6 7938.0 8127.6 8131.2 7891.7 8070.0 8074.3 8075.8 8078.9 2244.0 2268.3 2269.1 2270.1 2272.1 2260.9 2297.9 2312.5 2317.5 2317.8 2227.4 2238.4 2262.2 2262.3 2264.3 2125.0 2148.6 2161.4 2167.5 2168.4 2098.5 2114.3 2122.2 2122.8 2123.8 7771.2 7824.1 7904.4 7919.2 8175.6 4672.2 4712.3 4712.5 4716.1 4721.4 2941.5 2950.4 2993.4 3014.5 3044.8 907.6 923.4 924.0 932.3 938.8 10885.6 10907.5 10919.7 10977.8 10981.9 4014.1 4141.3 4162.9 4204.2 4208.4 8625.2 8677.0 8749.2 8761.9 8765.4 4693.5 4694.0 4697.1 4699.9 4703.0 3697.4 4189.1 4328.4 4402.5 4415.9 3410.3 3455.3 3458.3 3462.9 3551.3 1042.0 1053.9 1059.4 1080.5 1081.6 722.9 824.6 844.6 859.6 940.6 5261.6 5318.4 5338.5 5444.8 5521.4 934.8 960.8 975.1 977.0 988.0 3795.7 3823.7 3893.6 3973.3 4004.3 9798.4 10082.5 10161.8 10169.0 10194.6 9812.9 9989.1 10106.2 10180.6 10180.7 7446.9 7482.2 7579.6 7586.6 7611.1 5238.4 5260.5 5386.8 5410.9 5458.3 8841.1 9117.5 9145.5 9207.2 9212.2 8916.5 9200.0 9628.1 9639.3 9650.1 6996.9 7162.5 7173.8 7185.2 7220.5 7646.4 7755.6 7799.7 7801.3 7801.8 6820.0 7060.0 7089.0 7198.1 7255.5 6849.5 6885.1 6925.2 6981.5 7190.6 6343.3 6428.2 6452.7 6454.8 6461.0 4754.0 4771.1 4818.1 4917.2 4950.7 4993.2 5091.5 5126.3 5179.5 5221.1 08:14:08 INFO - PROCESS | 4600 | 08:14:08 INFO - PROCESS | 4600 | [#4] prototype.html Cycles:180 Average:4199.92 Median:4775.32 stddev:1214.34 (25.4%) stddev-sans-first:1181.46 08:14:08 INFO - PROCESS | 4600 | Values: 274.4 279.8 282.0 304.7 309.9 4771.4 4800.7 4818.6 4821.2 4841.3 4734.1 4775.8 4801.8 4822.9 4836.9 3597.5 3709.7 3738.7 3780.9 3835.3 3768.8 3798.3 3804.1 3816.8 3819.1 3592.6 3761.1 3773.0 3782.6 3796.4 3700.4 3783.8 3785.9 3793.1 3813.3 3359.5 3360.8 3371.3 3375.7 3379.2 4564.5 4590.8 4598.3 4606.5 4618.3 4219.2 4347.1 4358.8 4368.2 4369.9 5027.9 5035.6 5060.5 5077.9 5078.6 3669.7 3691.6 3694.5 3704.5 3707.3 4982.4 5258.9 5269.4 5274.3 5290.8 3651.3 3657.5 3680.9 3682.5 3683.0 3717.2 3721.5 3727.2 3729.3 3734.2 4218.0 4226.9 4289.2 4292.6 4293.5 4771.8 5006.5 5015.4 5044.9 5047.9 1276.6 1276.6 1286.9 1290.2 1292.4 825.6 837.2 871.7 889.8 895.5 4466.6 4475.4 4475.8 4491.2 4504.6 5123.9 5126.3 5149.1 5177.5 5207.4 4308.4 4377.2 4423.0 4460.2 4490.2 2728.7 2755.4 2765.5 2769.7 2782.2 4774.8 4821.5 4879.6 4908.0 4932.2 5107.3 5224.5 5251.9 5272.9 5279.9 4846.7 4870.8 4885.4 4889.1 4892.9 5124.1 5169.0 5172.8 5195.7 5205.2 4880.5 5049.0 5066.1 5145.0 5165.2 4983.6 4984.4 4986.0 4989.0 5000.0 3698.4 3736.2 3743.3 3747.0 3747.6 5043.7 5129.2 5223.5 5322.1 5326.7 5041.6 5059.6 5101.5 5110.3 5125.8 5103.8 5123.8 5152.0 5173.7 5173.9 4687.5 4761.3 5000.6 5087.8 5096.1 5029.4 5097.9 5121.8 5130.3 5130.9 4959.4 4991.1 4993.4 5010.6 5018.9 08:14:08 INFO - PROCESS | 4600 | 08:14:08 INFO - PROCESS | 4600 | [#5] yui.html Cycles:180 Average:12863.08 Median:51051.62 stddev:15052.30 (29.5%) stddev-sans-first:15067.04 08:14:08 INFO - PROCESS | 4600 | Values: 751.0 755.0 772.4 779.7 804.4 11830.1 11906.3 11965.5 11982.8 12021.2 12165.8 12433.9 12452.6 12460.2 12481.6 685.6 841.4 848.3 877.8 878.1 868.7 879.7 879.8 880.1 880.7 920.3 925.1 925.9 926.2 926.3 713.9 891.1 911.1 914.0 914.7 676.1 676.4 676.5 676.6 676.7 12162.8 12190.9 12196.3 12210.5 12222.1 11755.6 12043.2 12072.3 12093.4 12127.5 10660.4 10751.2 10853.3 10976.3 11036.4 3964.7 4026.7 4064.0 4071.5 4196.7 45464.3 45473.8 45570.0 47358.0 47826.3 9352.3 9382.2 9633.3 9670.9 9732.2 16847.6 17202.9 17371.2 17392.5 17395.2 6343.9 6382.6 6383.0 6446.3 6565.5 3669.6 3694.5 3725.4 3736.6 3767.5 2786.7 2885.1 2897.7 2897.9 2899.7 545.2 568.6 571.9 579.9 581.9 480.5 578.3 580.8 588.9 618.0 7806.6 8268.1 8299.9 8443.3 8465.1 473.7 550.9 562.1 571.5 572.2 3599.1 3600.3 3617.8 3631.6 3797.9 50960.0 51205.5 51311.0 51446.5 55908.0 49359.0 50470.5 50802.9 51143.2 51192.2 45991.3 46231.5 46292.8 46325.0 47016.5 6862.8 7066.8 7096.6 7157.9 7430.9 29741.9 29915.9 30423.7 30544.2 30715.2 36672.4 39429.0 40377.2 40476.8 41274.8 9818.0 10012.4 10070.3 10123.7 10170.8 11050.9 11265.2 11377.9 11398.8 11450.4 9947.0 10266.7 10431.3 10481.1 10503.5 9301.1 9635.6 9644.4 9700.1 9735.7 9211.5 9562.1 9655.6 9667.0 9674.9 8472.7 8556.1 8580.4 8638.0 8825.3 8474.9 8740.4 8962.8 10120.7 10166.5 08:14:08 INFO - PROCESS | 4600 | -------- Summary: end -------- 08:14:08 INFO - PROCESS | 4600 | 08:14:08 INFO - TEST-INFO | 4600: exit 0 08:14:08 INFO - TEST-OK | dromaeo_css | took 1118022ms 08:14:08 INFO - TEST-START | kraken 08:14:08 INFO - operating with platform_type : linux_ 08:14:08 INFO - Initialising browser for kraken test... 08:14:08 INFO - TEST-INFO | started process 4776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEsEyO0/profile http://localhost:34773/getInfo.html) 08:14:12 INFO - PROCESS | 4776 | __metrics Screen width/height:1600/1200 08:14:12 INFO - PROCESS | 4776 | colorDepth:24 08:14:12 INFO - PROCESS | 4776 | Browser inner width/height: 1024/697 08:14:12 INFO - PROCESS | 4776 | __metrics 08:14:13 ERROR - PROCESS | 4776 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:14:14 INFO - TEST-INFO | 4776: exit 0 08:14:14 INFO - Browser initialized. 08:14:14 INFO - Running cycle 1/1 for kraken test... 08:14:14 INFO - TEST-INFO | started process 4858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEsEyO0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:26 INFO - PROCESS | 4858 | RSS: Main: 154816512 08:14:26 INFO - PROCESS | 4858 | 08:14:28 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34773/tests/kraken/driver.html?testName=audio-beat-detection) 08:14:29 INFO - PROCESS | 4858 | RSS: Main: 210452480 08:14:29 INFO - PROCESS | 4858 | 08:14:32 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34773/tests/kraken/driver.html?testName=audio-dft) 08:14:33 INFO - PROCESS | 4858 | RSS: Main: 198328320 08:14:33 INFO - PROCESS | 4858 | 08:14:36 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34773/tests/kraken/driver.html?testName=audio-fft) 08:14:37 INFO - PROCESS | 4858 | RSS: Main: 266682368 08:14:37 INFO - PROCESS | 4858 | 08:14:39 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34773/tests/kraken/driver.html?testName=audio-oscillator) 08:14:40 INFO - PROCESS | 4858 | RSS: Main: 175947776 08:14:40 INFO - PROCESS | 4858 | 08:14:42 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:14:43 INFO - PROCESS | 4858 | RSS: Main: 180166656 08:14:43 INFO - PROCESS | 4858 | 08:14:46 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34773/tests/kraken/driver.html?testName=imaging-darkroom) 08:14:47 INFO - PROCESS | 4858 | RSS: Main: 216399872 08:14:47 INFO - PROCESS | 4858 | 08:14:50 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34773/tests/kraken/driver.html?testName=imaging-desaturate) 08:14:51 INFO - PROCESS | 4858 | RSS: Main: 214310912 08:14:51 INFO - PROCESS | 4858 | 08:14:54 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34773/tests/kraken/driver.html?testName=json-parse-financial) 08:14:54 INFO - PROCESS | 4858 | RSS: Main: 215064576 08:14:54 INFO - PROCESS | 4858 | 08:14:56 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:14:57 INFO - PROCESS | 4858 | RSS: Main: 210092032 08:14:57 INFO - PROCESS | 4858 | 08:14:59 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:14:59 INFO - PROCESS | 4858 | RSS: Main: 212312064 08:14:59 INFO - PROCESS | 4858 | 08:15:02 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:15:02 INFO - PROCESS | 4858 | RSS: Main: 217575424 08:15:02 INFO - PROCESS | 4858 | 08:15:05 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:15:06 INFO - PROCESS | 4858 | RSS: Main: 220479488 08:15:06 INFO - PROCESS | 4858 | 08:15:09 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:15:09 INFO - PROCESS | 4858 | RSS: Main: 216301568 08:15:09 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34773/tests/kraken/driver.html?testName=ai-astar) 08:15:11 INFO - PROCESS | 4858 | RSS: Main: 263692288 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | __start_tp_report 08:15:11 INFO - PROCESS | 4858 | _x_x_mozilla_page_load 08:15:11 INFO - PROCESS | 4858 | _x_x_mozilla_page_load_details 08:15:11 INFO - PROCESS | 4858 | |i|pagename|runs| 08:15:11 INFO - PROCESS | 4858 | |0;ai-astar;113;109;112;113;115;114;113;113;113;114 08:15:11 INFO - PROCESS | 4858 | |1;audio-beat-detection;152;133;151;208;139;158;152;130;198;130 08:15:11 INFO - PROCESS | 4858 | |2;audio-dft;160;161;159;160;161;161;161;163;161;161 08:15:11 INFO - PROCESS | 4858 | |3;audio-fft;74;76;76;157;75;76;78;76;136;75 08:15:11 INFO - PROCESS | 4858 | |4;audio-oscillator;93;92;150;93;93;93;123;93;93;120 08:15:11 INFO - PROCESS | 4858 | |5;imaging-gaussian-blur;117;116;116;116;116;117;116;117;116;117 08:15:11 INFO - PROCESS | 4858 | |6;imaging-darkroom;146;146;147;146;146;147;148;146;146;147 08:15:11 INFO - PROCESS | 4858 | |7;imaging-desaturate;94;95;95;94;94;94;94;95;94;95 08:15:11 INFO - PROCESS | 4858 | |8;json-parse-financial;63;64;63;65;65;62;64;63;66;63 08:15:11 INFO - PROCESS | 4858 | |9;json-stringify-tinderbox;64;64;64;64;65;65;63;65;64;65 08:15:11 INFO - PROCESS | 4858 | |10;stanford-crypto-aes;82;88;86;82;82;83;84;83;145;83 08:15:11 INFO - PROCESS | 4858 | |11;stanford-crypto-ccm;131;131;128;132;131;140;128;126;147;131 08:15:11 INFO - PROCESS | 4858 | |12;stanford-crypto-pbkdf2;168;169;172;168;168;167;173;173;169;163 08:15:11 INFO - PROCESS | 4858 | |13;stanford-crypto-sha256-iterative;67;67;70;66;65;65;66;65;65;64 08:15:11 INFO - PROCESS | 4858 | __end_tp_report 08:15:11 INFO - PROCESS | 4858 | __start_cc_report 08:15:11 INFO - PROCESS | 4858 | _x_x_mozilla_cycle_collect,2097 08:15:11 INFO - PROCESS | 4858 | __end_cc_report 08:15:11 INFO - PROCESS | 4858 | __startTimestamp1463152511966__endTimestamp 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | ------- Summary: start ------- 08:15:11 INFO - PROCESS | 4858 | Number of tests: 14 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.60 (1.4%) stddev-sans-first:1.69 08:15:11 INFO - PROCESS | 4858 | Values: 113.0 109.0 112.0 113.0 115.0 114.0 113.0 113.0 113.0 114.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:152.00 stddev:27.27 (17.9%) stddev-sans-first:28.90 08:15:11 INFO - PROCESS | 4858 | Values: 152.0 133.0 151.0 208.0 139.0 158.0 152.0 130.0 198.0 130.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 08:15:11 INFO - PROCESS | 4858 | Values: 160.0 161.0 159.0 160.0 161.0 161.0 161.0 163.0 161.0 161.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#3] audio-fft Cycles:10 Average:89.90 Median:76.00 stddev:30.26 (39.8%) stddev-sans-first:31.54 08:15:11 INFO - PROCESS | 4858 | Values: 74.0 76.0 76.0 157.0 75.0 76.0 78.0 76.0 136.0 75.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:93.00 stddev:20.01 (21.5%) stddev-sans-first:20.80 08:15:11 INFO - PROCESS | 4858 | Values: 93.0 92.0 150.0 93.0 93.0 93.0 123.0 93.0 93.0 120.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:15:11 INFO - PROCESS | 4858 | Values: 117.0 116.0 116.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 08:15:11 INFO - PROCESS | 4858 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 148.0 146.0 146.0 147.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:15:11 INFO - PROCESS | 4858 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 08:15:11 INFO - PROCESS | 4858 | Values: 63.0 64.0 63.0 65.0 65.0 62.0 64.0 63.0 66.0 63.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 08:15:11 INFO - PROCESS | 4858 | Values: 64.0 64.0 64.0 64.0 65.0 65.0 63.0 65.0 64.0 65.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:83.00 stddev:19.49 (23.5%) stddev-sans-first:20.47 08:15:11 INFO - PROCESS | 4858 | Values: 82.0 88.0 86.0 82.0 82.0 83.0 84.0 83.0 145.0 83.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:131.00 stddev:6.31 (4.8%) stddev-sans-first:6.67 08:15:11 INFO - PROCESS | 4858 | Values: 131.0 131.0 128.0 132.0 131.0 140.0 128.0 126.0 147.0 131.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.00 stddev:3.06 (1.8%) stddev-sans-first:3.22 08:15:11 INFO - PROCESS | 4858 | Values: 168.0 169.0 172.0 168.0 168.0 167.0 173.0 173.0 169.0 163.0 08:15:11 INFO - PROCESS | 4858 | 08:15:11 INFO - PROCESS | 4858 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.70 (2.6%) stddev-sans-first:1.76 08:15:11 INFO - PROCESS | 4858 | Values: 67.0 67.0 70.0 66.0 65.0 65.0 66.0 65.0 65.0 64.0 08:15:11 INFO - PROCESS | 4858 | -------- Summary: end -------- 08:15:11 INFO - PROCESS | 4858 | 08:15:12 INFO - TEST-INFO | 4858: exit 0 08:15:13 INFO - TEST-OK | kraken | took 64144ms 08:15:13 INFO - SUITE-END | took 1182s 08:15:13 INFO - Completed test suite (00:19:42) 08:15:13 INFO - javascript benchmark 08:15:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2666.6000099985, 2671.9866400667993, 2704.215777424547, 2707.269037359912, 2714.7285271472856, 4670.206064968955, 4718.433787945447, 4753.572178503934, 4796.328514008037, 4843.685160464572, 4749.8812529686775, 4789.497102804207, 4805.423349198092, 4813.3983252093485, 4848.393950756155, 4357.498887627924, 4363.170997510479, 4422.336649502568, 4473.776311184444, 4553.248713962193, 4459.620932220765, 4501.504834468222, 4522.163399771036, 4522.29904364824, 4551.203539380595, 4315.956840431587, 4334.631556317717, 4350.042990542076, 4359.738415695068, 4403.097365040175, 4403.515613282536, 4404.207242696313, 4407.691461597689, 4411.42651455312, 4451.532589078132, 4410.514843367227, 4418.1384629997165, 4420.270655341865, 4468.977655111737, 4474.552544745532, 4596.448426188846, 4673.813047478096, 4739.12326219647, 4751.501092385284, 4798.136335459616, 5191.428942816287, 5213.635045546814, 5254.133068043769, 5255.921161182585, 5259.658122222043, 5233.293505376763, 5260.526552610283, 5279.947200527984, 5287.074761916688, 5288.180332048539, 4632.25883858581, 4712.387389639325, 4792.849716068154, 4828.203346447796, 4830.203016502308, 5311.176767601028, 5336.893262134736, 5341.545968592635, 5342.332208473941, 5357.732113394315, 5058.595312375001, 5083.949160508421, 5113.923291150636, 5126.1798112302595, 5128.897422051613, 5031.647784655039, 5093.23601459784, 5135.897282054338, 5142.897142057138, 5169.457206993212, 5092.592592592584, 5125.282460455539, 5133.178691409356, 5138.100832354323, 5185.922211166836, 4979.103761322996, 5104.668196567211, 5110.105731496973, 5112.105381558213, 5113.565346945476, 4218.7679677618025, 4276.850310239127, 4279.679024073207, 4287.2711639021445, 4287.849925252601, 3757.774533527997, 3767.3218820612005, 3767.585565587783, 3777.0557360659836, 3808.7143464240294, 4341.717788343748, 4381.452318460192, 4448.955510444919, 4457.866264012085, 4490.685652004394, 5120.948790512121, 5130.563902068291, 5132.56373208274, 5197.194434862527, 5198.662086964335, 4436.556344365602, 4467.218236808546, 4468.4414448193975, 4468.910621787546, 4518.593326600621, 4510.255807791677, 4554.476235232991, 4626.467956185014, 4632.305154226893, 4672.859814205579, 4842.854714358646, 4861.927071094007, 4864.537868902448, 4885.316055752127, 4926.458089610212, 5125.308083408692, 5134.28120063184, 5146.330976972969, 5161.174212126042, 5196.584273258055, 4642.791074401593, 4768.117898188846, 4815.855524334275, 4877.512248775236, 4937.580305674058, 4990.575801056951, 5016.523430274118, 5016.673916195436, 5022.221555658879, 5044.445111037856, 5065.822696205615, 5074.847754567369, 5075.1625981712605, 5081.898362032664, 5115.897682046264, 4830.468648448597, 4916.311716359784, 4946.579540738933, 4993.80024799004, 4996.2755400466, 4976.253561965734, 4997.150484417585, 5002.099622068063, 5004.074246264453, 5054.19132938728, 4929.211326187936, 4940.283658869372, 4946.752662366939, 4988.226824842155, 4988.501149884983, 4896.583790377716, 4988.700677959334, 5026.673266237683, 5054.140796064751, 5086.694798312114, 4940.802367905244, 4959.975200123977, 4963.528464795839, 4968.726720030433, 5014.022265658162], "value": 4715.089568363084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.9020171469991, 584.9151872978418, 591.801746414951, 602.9547783916207, 614.8739508400777, 41671.79164104179, 42948.57051429485, 43008.354874676865, 43153.0, 46566.76716616412, 42933.57066429335, 43203.35194972078, 43333.566664333346, 43415.78292108543, 43423.0, 8017.639206235719, 8148.22591853773, 8150.877736833952, 8151.918480815205, 8155.632996515142, 7959.204079592024, 8037.437379383446, 8048.074471435772, 8053.516788992679, 8059.314958228558, 8021.157778433268, 8087.3934454915825, 8121.30968867647, 8125.59372031399, 8125.959370203141, 7916.445848790587, 8034.638441270127, 8045.356371490267, 8066.838663226703, 8067.394945379061, 7917.168697286759, 7997.560134192617, 7997.720079797179, 7999.440039197259, 8001.239882211181, 39468.407973880414, 39786.403203951966, 39793.60206397928, 39819.20361592781, 39836.20327593432, 3232.595925509311, 3257.641659417462, 3442.6041005284465, 3721.7394782365245, 3805.2769973705185, 29239.2690182745, 29770.255743606365, 30089.0, 30390.54414183789, 30903.845480772452, 2988.5965394671657, 3058.6023816903885, 3090.7681923855575, 3103.0, 3140.905772826819, 276331.0, 278362.0, 278723.99999999796, 278902.0, 280474.0, 52913.47086529085, 53212.73393633084, 53276.46723532715, 53365.0, 53408.0, 51103.23345149826, 57230.0, 57918.4208157913, 59420.7028964861, 59481.0, 15596.532104036896, 15768.526944191693, 15824.525264242091, 15837.604059898364, 15841.287142078634, 12137.0, 12243.755124897452, 12245.0, 12251.93874030642, 12254.509819607294, 14256.073355231876, 15748.291326890318, 15803.13082780435, 16042.75935860963, 16249.106299153424, 5999.610025348338, 6115.951156362579, 6146.385361463817, 6192.102145188923, 6228.532860035515, 933.0, 949.7103383468109, 991.6529214774771, 998.3163315836416, 1074.9841399877198, 27988.739877288175, 28677.0, 28687.0, 29106.27234319159, 29157.27106822304, 1037.2790910317408, 1064.9361038337724, 1068.9465526723632, 1084.4415126210008, 1087.907527860125, 15123.470678526199, 15453.5363939082, 15465.0, 15552.377904883679, 15557.0, 338411.0, 338534.0, 339297.0, 342291.0, 342414.0, 49581.752091240036, 50503.24245136326, 50593.24110138351, 50692.746536267085, 50820.49179508157, 1180.9586664466703, 1211.54567037361, 1214.732758793064, 1284.8393950756156, 1315.5333749220213, 24357.51284974255, 30220.84889575626, 30477.54283685791, 32658.183545411553, 33212.33575328528, 48422.273665895744, 49166.508334916194, 49202.0, 49277.75361123172, 49359.259611105146, 344567.0, 348045.0, 348179.0, 349379.0, 349892.0, 33001.50497742584, 35670.68750906006, 37023.88928332154, 37462.0, 37643.811780942015, 39318.803405982784, 43183.568164317956, 43444.78277608718, 43613.78193109141, 43692.34461483144, 37162.442563362114, 37259.44110838285, 37300.81349593234, 37551.0, 37698.81150594229, 36100.81949590235, 36173.0, 36289.63710362863, 36699.63300366962, 36801.447978279815, 35650.0, 35768.28463430665, 36016.63983360238, 36017.0, 37200.25599487941, 29829.403411931205, 32090.19774505656, 32749.181270468427, 32880.50679239765, 32981.0, 24896.751032489443, 24982.875085624455, 25017.499650007263, 25199.11803086883, 25464.74535254698], "value": 18218.25673320669, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.7829302418549, 365.8244042859427, 374.11521751058757, 381.1367253171565, 381.3935842011202, 16327.183640817957, 17202.39791607294, 17282.0, 17500.124993750323, 17617.91191044043, 16400.179991000463, 16703.582410439743, 17844.197011134496, 17851.375201867937, 17853.821461785377, 4579.450465944083, 4755.120302743986, 4795.2087905495555, 4803.5676789088975, 4808.783604737778, 3395.2190996070917, 4710.599599034069, 5030.396352437712, 5290.470952904717, 5299.258103865462, 5307.65500242483, 5336.733163341837, 5350.625456218067, 5357.973210133944, 5361.08861493547, 5134.460881607433, 5197.454267301936, 5249.317588713462, 5252.501012403815, 5260.316158899319, 3182.809031458097, 4984.526469985346, 5047.47001564834, 5280.709560974145, 5288.418273989858, 11289.661310160709, 11308.208425410225, 11417.200795944287, 11433.14251431146, 11950.0, 1879.8590105741987, 1884.1615481110912, 1911.4934542346289, 1925.4993701637536, 2056.393363957636, 9145.679901203492, 9287.210587100104, 9485.383450075791, 9490.145886870147, 9636.421814691072, 1581.7311057120203, 1697.5671203843065, 1721.6040310728476, 1757.4551888914477, 1845.9446216613524, 63445.68277158631, 67081.329186708, 68499.0, 76474.0, 76814.23185768182, 9530.904690953003, 9571.856422153673, 9681.757956051155, 9797.363171393836, 9873.308868379145, 12773.872261277455, 13021.674458138623, 13093.279869607262, 13132.0, 13194.604161875159, 6792.422644075309, 6878.174619045746, 6882.311768823178, 6961.060256865258, 7005.124359455068, 6487.805365839033, 6579.75800290787, 6650.634215118215, 6651.068850360954, 6655.866882662416, 3998.960010399917, 4113.177364527107, 4269.87190384289, 4274.508431530352, 4276.401303817468, 1612.1939030484757, 1632.4368093007893, 1746.6419384026499, 1828.743975843383, 1877.7840548337117, 862.5945805471418, 915.6428992692855, 962.2686758063921, 962.6919385796477, 986.7631768375538, 16806.243719032675, 17197.914010429868, 17277.913610431868, 17386.565335866704, 17573.560660983578, 939.0656296984544, 944.8724422203052, 957.7461972577272, 957.861110139026, 962.7496850818837, 9370.906290937004, 9846.163076138466, 9854.704358869245, 9860.359076659994, 9911.207103431709, 363346.0, 364205.0, 364343.0, 373673.0, 376074.0, 80612.59693701494, 80700.59649701713, 80822.59588702019, 81184.0, 82205.58897205476, 903.290916630442, 906.5376657904516, 923.4690053219291, 928.8560273157672, 930.251147825993, 15187.468438604596, 15200.391984320504, 15371.692566148839, 15427.691446171239, 15543.300551474984, 36623.26753464969, 37127.0, 37437.251254975294, 37517.06207344838, 37590.0, 44727.0, 46645.30032049454, 48601.513984859695, 49072.50927490679, 51789.223161651855, 6757.391834734897, 7039.120109986252, 7179.246179151114, 7608.16310205888, 7739.993800806084, 11512.827307590225, 11715.472803723682, 11947.283163010246, 12140.817887731868, 12287.262764234174, 10575.471226438493, 10642.467876606293, 10681.786364272826, 10763.3541987481, 10866.96763807437, 5251.159814429673, 8370.53962032094, 10228.897711023092, 10266.716660417447, 10363.119134873621, 10597.4701264938, 10602.469876506299, 10860.891391085988, 10890.346579205274, 11000.724981875517, 6594.439472644687, 6979.651017449209, 7124.536905101152, 7238.963805180941, 7300.926990730025, 9014.684486042957, 10349.275550711378, 10466.215033872642, 10561.10230630405, 10765.784684306112], "value": 7949.918076661807, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.4018151650241, 1521.383839544984, 1534.8004759381279, 1697.9915100424503, 1883.8681292309536, 7569.129550101733, 7908.565028923407, 7938.047434307877, 8127.5529845858455, 8131.186881311866, 7891.684332626703, 8069.959650201756, 8074.3136833369235, 8075.829004794301, 8078.9192108078905, 2244.0350649220827, 2268.25147701259, 2269.069681430614, 2270.114655284432, 2272.1138755885136, 2260.9321720348416, 2297.8965946532444, 2312.537492501498, 2317.536492701458, 2317.8377513574055, 2227.40973641985, 2238.3956331790405, 2262.151693115082, 2262.298687406901, 2264.286749673856, 2125.0224896547606, 2148.6132496150685, 2161.438026113206, 2167.53398019425, 2168.425367277665, 2098.4648914526697, 2114.302280247515, 2122.206735308662, 2122.777108403611, 2123.819475344598, 7771.184025677279, 7824.061112666516, 7904.446688731791, 7919.247671471201, 8175.5503447310375, 4672.182368085571, 4712.293156026589, 4712.505186955389, 4716.127516409475, 4721.433427988629, 2941.5440606705993, 2950.4099180164053, 2993.3863557970562, 3014.4724673182104, 3044.8325342106177, 907.5779762410444, 923.3536524432857, 923.9630414783401, 932.2868005975434, 938.7606160429115, 10885.564577416893, 10907.509162087725, 10919.727006824813, 10977.83533247002, 10981.945090274497, 4014.1369605534364, 4141.275276826544, 4162.937555936664, 4204.1801848639225, 4208.368744688321, 8625.180607842245, 8677.045524992245, 8749.212570868653, 8761.912380876238, 8765.430247033923, 4693.507181745936, 4693.95306046942, 4697.060587882437, 4699.882502937454, 4702.976485117552, 3697.4268988306853, 4189.099343641071, 4328.3723860040745, 4402.515723270438, 4415.933760993587, 3410.3349846780134, 3455.2571197192224, 3458.2564748578675, 3462.8614855406004, 3551.3074950384944, 1042.0465274274106, 1053.9262251642465, 1059.4384975962753, 1080.5137688040256, 1081.6376513867785, 722.8590424867206, 824.5629816197425, 844.5861527851308, 859.58739804894, 940.6284517615503, 5261.605379596545, 5318.361796584435, 5338.519533242027, 5444.8094316698725, 5521.4478552144465, 934.817710546437, 960.8259522471541, 975.0639386189196, 976.9658061967939, 987.9950600247097, 3795.658390744846, 3823.6941044716355, 3893.552241492208, 3973.264945985002, 4004.3192657248337, 9798.363106398061, 10082.495875206358, 10161.847572286422, 10169.0, 10194.643187488402, 9812.90187098134, 9989.051040151175, 10106.191504679608, 10180.592776288866, 10180.694579162637, 7446.888296675555, 7482.176960534337, 7579.62101894903, 7586.62066896664, 7611.086669599573, 5238.397584277857, 5260.500252476008, 5386.8383948481605, 5410.918836217538, 5458.263134476795, 8841.115888411108, 9117.544122793966, 9145.451272923647, 9207.17135457812, 9212.216961558343, 8916.465012099035, 9200.033996430546, 9628.133467987915, 9639.277054220822, 9650.08324209199, 6996.860062798817, 7162.498625096193, 7173.784786456415, 7185.17370502378, 7220.530665506725, 7646.350060244941, 7755.573443460664, 7799.688012479437, 7801.258880406353, 7801.765947021599, 6820.04519367279, 7059.964700176466, 7089.042979197742, 7198.136223653195, 7255.4921155518605, 6849.520533562602, 6885.070515480546, 6925.20360158568, 6981.5461994970165, 7190.568565886064, 6343.3339499351905, 6428.228612566522, 6452.709628066655, 6454.806355809334, 6461.0, 4753.9762301188275, 4771.093492236603, 4818.084563932842, 4917.237828136645, 4950.6782059166035, 4993.17612593918, 5091.490850914879, 5126.307948426915, 5179.482051794941, 5221.138512145605], "value": 4250.070842581654, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.3525280338401, 279.8195164119142, 281.9873105710244, 304.6739988212612, 309.94421004219237, 4771.35586695796, 4800.735959522225, 4818.638602104838, 4821.156297647911, 4841.273808928662, 4734.147853386397, 4775.808967641299, 4801.84755658642, 4822.890735130922, 4836.854894353166, 3597.4603809428663, 3709.684676802475, 3738.663520283174, 3780.8676696315633, 3835.3479908415497, 3768.8492460301554, 3798.2973149967343, 3804.068003339186, 3816.809159542012, 3819.140693344003, 3592.5868525119686, 3761.13493896404, 3772.9811350943205, 3782.583915769263, 3796.4305354196817, 3700.4079347304437, 3783.8297276622343, 3785.867494637702, 3793.146542028049, 3813.3326667833294, 3359.5296658467832, 3360.83195840207, 3371.325734853039, 3375.71306438953, 3379.172102834821, 4564.5435456454425, 4590.770461476946, 4598.287265473857, 4606.470255920579, 4618.2610782275015, 4219.198352313051, 4347.130573885235, 4358.8038538265855, 4368.213721530124, 4369.912601747979, 5027.899442011176, 5035.640377098163, 5060.544550990392, 5077.949220507785, 5078.5937125029905, 3669.6513831185994, 3691.6492933171307, 3694.5197124373926, 3704.5369328833895, 3707.3326801175776, 4982.377202849644, 5258.868528286824, 5269.394019687747, 5274.314339135926, 5290.814821481268, 3651.3062518121474, 3657.5062366580173, 3680.9447858282147, 3682.502862113634, 3682.9815850920572, 3717.1636381813873, 3721.4603882436895, 3727.235916637083, 3729.284529116637, 3734.2344819311975, 4217.957820421757, 4226.936595951063, 4289.1850548395705, 4292.613664770123, 4293.549177336335, 4771.785269662873, 5006.4743201964, 5015.448300686921, 5044.873878153002, 5047.924281135786, 1276.6233960981533, 1276.6489215465822, 1286.9163504372186, 1290.167841742071, 1292.3667402972665, 825.6078362777632, 837.2172019162103, 871.7428358634218, 889.782003409156, 895.4627223665749, 4466.553344665507, 4475.395821564112, 4475.843345482893, 4491.214037543416, 4504.648605418427, 5123.948760512347, 5126.256692779601, 5149.094834911032, 5177.534021938043, 5207.3751149862255, 4308.439902812677, 4377.212101821703, 4422.977885110554, 4460.1525710114975, 4490.191765482179, 2728.7271272872554, 2755.3800394910986, 2765.502209602251, 2769.739768405371, 2782.2348854065294, 4774.832880849153, 4821.54195351441, 4879.608991594164, 4907.975460122677, 4932.161532539477, 5107.293134638648, 5224.52979231871, 5251.921221181686, 5272.894542109137, 5279.947200528022, 4846.733429661403, 4870.756462176806, 4885.438174609894, 4889.144399730033, 4892.8532144035735, 5124.12889808726, 5168.9741551292, 5172.844814655567, 5195.6622819516615, 5205.193195054772, 4880.536349046835, 5048.974755126201, 5066.113430149783, 5144.993452553433, 5165.225216217597, 4983.601311895112, 4984.352034235526, 4985.9501404985485, 4989.0, 4999.950000499948, 3698.389765688631, 3736.215394767021, 3743.3262012836863, 3746.981265093657, 3747.6065013174316, 5043.722595257149, 5129.204973229155, 5223.503767142115, 5322.095243808484, 5326.721586819213, 5041.6470847040355, 5059.595232381327, 5101.540861322499, 5110.284560161655, 5125.846224613268, 5103.8468845934685, 5123.795048198031, 5151.974240128925, 5173.689578625294, 5173.948260517347, 4687.460941991714, 4761.309610106585, 5000.599952003904, 5087.771050302671, 5096.108181068373, 5029.4216165140015, 5097.92353114711, 5121.7695203715175, 5130.307408499804, 5130.897382052263, 4959.380077490314, 4991.0784348025545, 4993.400791904995, 5010.599152067753, 5018.899622007612], "value": 3810.853140458316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.0311697909693, 754.9584772837493, 772.3820943245403, 779.695918591749, 804.3565147881695, 11830.112741544375, 11906.34515101669, 11965.461554230058, 11982.7603447931, 12021.15851890368, 12165.817512737316, 12433.875661243384, 12452.564160254393, 12460.190087644296, 12481.563145289916, 685.6263336481604, 841.4488510025943, 848.3298194426395, 877.7586163804941, 878.056089703568, 868.7176667583029, 879.7360791762478, 879.7976465412959, 880.1154839386408, 880.6565439478609, 920.2821798996794, 925.1165137293901, 925.9259259259243, 926.2173463423396, 926.3191554207652, 713.8929160625947, 891.1088911088912, 911.1207684584408, 913.9817203655923, 914.6615752171706, 676.0940339944498, 676.4047638078508, 676.47573130824, 676.5534747066962, 676.719161547957, 12162.817557736642, 12190.939045304716, 12196.329201893892, 12210.511579536807, 12222.144449888512, 11755.58855440064, 12043.191837138984, 12072.336021518813, 12093.395330233454, 12127.454264558117, 10660.413677247749, 10751.193660475417, 10853.34879907208, 10976.286541374864, 11036.448177591168, 3964.6630036446936, 4026.7382620129597, 4063.97968010161, 4071.470708807836, 4196.748195108304, 45464.318035229495, 45473.772631136635, 45570.0, 47358.0, 47826.28260576059, 9352.345335826563, 9382.155605995493, 9633.277504187214, 9670.854937175947, 9732.221422286342, 16847.578810529834, 17202.913985429994, 17371.218295176746, 17392.47822565325, 17395.217215225344, 6343.873122537523, 6382.648954307558, 6383.042543618494, 6446.323136070739, 6565.540412171198, 3669.633036696309, 3694.4827724118645, 3725.403935370328, 3736.626337366242, 3767.547894252707, 2786.721327867197, 2885.1488810800865, 2897.652281726206, 2897.884084636633, 2899.695531969113, 545.2312239741944, 568.6048196503473, 571.9199312096309, 579.8579348059752, 581.9127130930394, 480.5362824873944, 578.2511647416605, 580.7705956147382, 588.8645611509377, 617.9907301390393, 7806.570638614817, 8268.131846156188, 8299.917000829915, 8443.282321002784, 8465.068842427328, 473.7015680121501, 550.931133608299, 562.0753859900523, 571.5341996273024, 572.2104739395447, 3599.1002249437643, 3600.279944011208, 3617.819109044537, 3631.6368363163474, 3797.905052373713, 50960.0, 51205.48794512082, 51311.0, 51446.485535144915, 55908.0, 49359.0, 50470.49529504658, 50802.91970802964, 51143.23285150726, 51192.23211651828, 45991.31013034807, 46231.53768462272, 46292.768536157775, 46325.0, 47016.5298347019, 6862.828429289308, 7066.823329416806, 7096.645167741695, 7157.856842863218, 7430.851382972419, 29741.85129074341, 29915.850420747756, 30423.695763042087, 30544.236394090327, 30715.2321191972, 36672.44991325079, 39429.0, 40377.1924561513, 40476.79761601291, 41274.79362603288, 9817.992203213242, 10012.44931528773, 10070.295079344376, 10123.696289111338, 10170.79658406813, 11050.889491104987, 11265.155113366694, 11377.886221137682, 11398.829017564909, 11450.427478625868, 9947.0, 10266.743331416774, 10431.269811113452, 10481.056704896597, 10503.47482625881, 9301.069893010645, 9635.5663995119, 9644.373115747454, 9700.126988571063, 9735.659251926148, 9211.539423028957, 9562.139407453084, 9655.565499552396, 9667.0, 9674.9032509674, 8472.691181677961, 8556.058833528183, 8580.442271252348, 8637.956810215908, 8825.338099642424, 8474.872876906975, 8740.388172828096, 8962.820743585222, 10120.696379108638, 10166.475287193376], "value": 5945.242541041331, "unit": "score"}], "name": "dromaeo_css", "value": 6353.301979093255, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 112.0, 113.0, 115.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 133.0, 151.0, 208.0, 139.0, 158.0, 152.0, 130.0, 198.0, 130.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 160.0, 161.0, 161.0, 161.0, 163.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 157.0, 75.0, 76.0, 78.0, 76.0, 136.0, 75.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 150.0, 93.0, 93.0, 93.0, 123.0, 93.0, 93.0, 120.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 65.0, 65.0, 62.0, 64.0, 63.0, 66.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 63.0, 65.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 88.0, 86.0, 82.0, 82.0, 83.0, 84.0, 83.0, 145.0, 83.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 128.0, 132.0, 131.0, 140.0, 128.0, 126.0, 147.0, 131.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 172.0, 168.0, 168.0, 167.0, 173.0, 173.0, 169.0, 163.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1565.6999999999998, "alertThreshold": 2.0}]} 08:15:13 INFO - Return code: 0 08:15:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:15:13 ERROR - # TBPL SUCCESS # 08:15:13 INFO - Running post-action listener: _resource_record_post_action 08:15:13 INFO - ##### 08:15:13 INFO - ##### Finished run-tests step (success) 08:15:13 INFO - ##### 08:15:13 INFO - Running post-run listener: _resource_record_post_run 08:15:13 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 425984; Write bytes: 295788544; Read time: 52; Write time: 198708 08:15:13 INFO - TinderboxPrint: CPU usage
13.1% 08:15:13 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 52 08:15:13 INFO - TinderboxPrint: I/O write bytes / time
295,788,544 / 198,708 08:15:13 INFO - TinderboxPrint: CPU idle
8,318.8 (86.9%) 08:15:13 INFO - TinderboxPrint: CPU user
1,212.5 (12.7%) 08:15:13 INFO - TinderboxPrint: Swap in / out
0 / 0 08:15:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13369344; Read time: 0; Write time: 2716 08:15:13 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 425984; Write bytes: 278282240; Read time: 52; Write time: 192144 08:15:13 INFO - Running post-run listener: _upload_blobber_files 08:15:13 INFO - Blob upload gear active. 08:15:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:15:13 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 08:15:13 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'] 08:15:13 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 08:15:14 INFO - (blobuploader) - INFO - Open directory for files ... 08:15:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:15:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:15:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:18 INFO - (blobuploader) - INFO - Done attempting. 08:15:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:15:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:15:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:19 INFO - (blobuploader) - INFO - Done attempting. 08:15:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:15:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:15:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:20 INFO - (blobuploader) - INFO - Done attempting. 08:15:20 INFO - (blobuploader) - INFO - Iteration through files over. 08:15:20 INFO - Return code: 0 08:15:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:15:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:15:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af30901977b2d46741ac5a7d69fddaf160f1d19fa8dc459259f662ca4e08c5428a45dec8bea68ecb9c52f24f6f3c1e4d6578f3df6b177c371ff85e1ebbd9d419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d1384c2b5237ea0f311321c05f744257031cf03538315b29e208aba4139b30a785d8a5d4f3d409ebbc022b68e9d253783304e7e62415f1ebb64259b403c05484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317d5f0b78978a10060c5a092bd830f0f1002bab0b85cc2d38423756527d77dcb4a4f8f90b52f11b6e8a3d55109761ead4ee8daf0ed7636faa81e9c07dd88d1d"} 08:15:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:15:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:15:20 INFO - Contents: 08:15:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af30901977b2d46741ac5a7d69fddaf160f1d19fa8dc459259f662ca4e08c5428a45dec8bea68ecb9c52f24f6f3c1e4d6578f3df6b177c371ff85e1ebbd9d419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d1384c2b5237ea0f311321c05f744257031cf03538315b29e208aba4139b30a785d8a5d4f3d409ebbc022b68e9d253783304e7e62415f1ebb64259b403c05484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317d5f0b78978a10060c5a092bd830f0f1002bab0b85cc2d38423756527d77dcb4a4f8f90b52f11b6e8a3d55109761ead4ee8daf0ed7636faa81e9c07dd88d1d"} 08:15:20 INFO - Running post-run listener: copy_logs_to_upload_dir 08:15:20 INFO - Copying logs to upload dir... 08:15:20 INFO - mkdir: /builds/slave/test/build/upload/logs 08:15:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.881261 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-13 08:15:20.583546) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 08:15:20.586813) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503 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/af30901977b2d46741ac5a7d69fddaf160f1d19fa8dc459259f662ca4e08c5428a45dec8bea68ecb9c52f24f6f3c1e4d6578f3df6b177c371ff85e1ebbd9d419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d1384c2b5237ea0f311321c05f744257031cf03538315b29e208aba4139b30a785d8a5d4f3d409ebbc022b68e9d253783304e7e62415f1ebb64259b403c05484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317d5f0b78978a10060c5a092bd830f0f1002bab0b85cc2d38423756527d77dcb4a4f8f90b52f11b6e8a3d55109761ead4ee8daf0ed7636faa81e9c07dd88d1d"} build_url:https://queue.taskcluster.net/v1/task/P-N-47h_TVSQhDimJ9N7jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/P-N-47h_TVSQhDimJ9N7jg/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/af30901977b2d46741ac5a7d69fddaf160f1d19fa8dc459259f662ca4e08c5428a45dec8bea68ecb9c52f24f6f3c1e4d6578f3df6b177c371ff85e1ebbd9d419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d1384c2b5237ea0f311321c05f744257031cf03538315b29e208aba4139b30a785d8a5d4f3d409ebbc022b68e9d253783304e7e62415f1ebb64259b403c05484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317d5f0b78978a10060c5a092bd830f0f1002bab0b85cc2d38423756527d77dcb4a4f8f90b52f11b6e8a3d55109761ead4ee8daf0ed7636faa81e9c07dd88d1d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 08:15:20.610515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 08:15:20.610817) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1463151070.493060-1658908503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 08:15:20.693069) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 08:15:20.693396) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 08:15:20.693785) ========= ========= Total master_lag: 0.14 =========